builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0050 starttime: 1460028943.01 results: success (0) buildid: 20160407043449 builduid: 637956fa679e478c93a4ef2f21f58511 revision: 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 04:35:43.012992) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 04:35:43.013418) ========= ========= Started set props: basedir (results: 0, elapsed: 17 secs) (at 2016-04-07 04:35:43.017743) ========= 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.yqNkGaBCtR/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.QNbrZt2xPh/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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.005723 basedir: '/builds/slave/test' ========= master_lag: 17.52 ========= ========= Finished set props: basedir (results: 0, elapsed: 17 secs) (at 2016-04-07 04:36:00.545654) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 40 secs) (at 2016-04-07 04:36:00.545960) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 40 secs) (at 2016-04-07 04:36:41.369010) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-04-07 04:36:41.369286) ========= 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.yqNkGaBCtR/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.QNbrZt2xPh/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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.006100 ========= master_lag: 1.94 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-04-07 04:36:43.317898) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 04:36:43.318171) ========= 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:36:43.318508) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-07 04:36:43.318802) ========= 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.yqNkGaBCtR/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.QNbrZt2xPh/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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:36:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 17.4M=0.001s 2016-04-07 04:36:46 (17.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.309500 ========= master_lag: 3.57 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-07 04:36:47.201346) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-04-07 04:36:47.201636) ========= 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.yqNkGaBCtR/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.QNbrZt2xPh/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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.027310 ========= master_lag: 3.77 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-04-07 04:36:51.002450) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-04-07 04:36:51.002797) ========= 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.yqNkGaBCtR/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.QNbrZt2xPh/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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:36:52,112 truncating revision to first 12 chars 2016-04-07 04:36:52,112 Setting DEBUG logging. 2016-04-07 04:36:52,112 attempt 1/10 2016-04-07 04:36:52,112 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:36:53,701 unpacking tar archive at: mozilla-central-68c0b7d6f16c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.837742 ========= master_lag: 4.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-04-07 04:36:56.871865) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 8 secs) (at 2016-04-07 04:36:56.872188) ========= 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.yqNkGaBCtR/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.QNbrZt2xPh/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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.005928 script_repo_revision: '68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8' ========= master_lag: 8.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 8 secs) (at 2016-04-07 04:37:04.913775) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 5 secs) (at 2016-04-07 04:37:04.914101) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 5 secs) (at 2016-04-07 04:37:09.989895) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-04-07 04:37:09.990202) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yqNkGaBCtR/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.QNbrZt2xPh/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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:37:10 INFO - MultiFileLogger online at 20160407 04:37:10 in /builds/slave/test 04:37:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:37:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:37:10 INFO - {'append_to_log': False, 04:37:10 INFO - 'base_work_dir': '/builds/slave/test', 04:37:10 INFO - 'blob_upload_branch': 'Firefox', 04:37:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:37:10 INFO - 'branch': 'Firefox', 04:37:10 INFO - 'buildbot_json_path': 'buildprops.json', 04:37:10 INFO - 'config_files': ('talos/mac_config.py',), 04:37:10 INFO - 'default_actions': ('clobber', 04:37:10 INFO - 'read-buildbot-config', 04:37:10 INFO - 'download-and-extract', 04:37:10 INFO - 'populate-webroot', 04:37:10 INFO - 'create-virtualenv', 04:37:10 INFO - 'install', 04:37:10 INFO - 'run-tests'), 04:37:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:37:10 INFO - 'download_minidump_stackwalk': True, 04:37:10 INFO - 'download_symbols': 'ondemand', 04:37:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:37:10 INFO - 'tooltool.py': '/tools/tooltool.py', 04:37:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:37:10 INFO - '/tools/misc-python/virtualenv.py')}, 04:37:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:37:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:37:10 INFO - 'installer_path': 'installer.exe', 04:37:10 INFO - 'log_level': 'info', 04:37:10 INFO - 'log_name': 'talos', 04:37:10 INFO - 'log_to_console': True, 04:37:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:37:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:37:10 INFO - 'opt_config_files': (), 04:37:10 INFO - 'pip_index': False, 04:37:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:37:10 INFO - 'cmd': ('bash', 04:37:10 INFO - '-c', 04:37:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:37:10 INFO - 'enabled': True, 04:37:10 INFO - 'halt_on_failure': False, 04:37:10 INFO - 'name': 'check_screen_resolution'},), 04:37:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:37:10 INFO - 'cmd': ('bash', 04:37:10 INFO - '-c', 04:37:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:37:10 INFO - 'enabled': True, 04:37:10 INFO - 'halt_on_failure': False, 04:37:10 INFO - 'name': 'check_screen_resolution'},), 04:37:10 INFO - 'run_cmd_checks_enabled': True, 04:37:10 INFO - 'sps_profile': False, 04:37:10 INFO - 'sps_profile_interval': 0, 04:37:10 INFO - 'suite': 'dromaeojs-e10s', 04:37:10 INFO - 'system_bits': '32', 04:37:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:37:10 INFO - 'title': 't-yosemite-r7-0050', 04:37:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:37:10 INFO - 'use_talos_json': True, 04:37:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:37:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:37:10 INFO - 'work_dir': 'build'} 04:37:10 INFO - ##### 04:37:10 INFO - ##### Running clobber step. 04:37:10 INFO - ##### 04:37:10 INFO - Running pre-action listener: _resource_record_pre_action 04:37:10 INFO - Running main action method: clobber 04:37:10 INFO - rmtree: /builds/slave/test/build 04:37:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:37:11 INFO - Running post-action listener: _resource_record_post_action 04:37:11 INFO - ##### 04:37:11 INFO - ##### Running read-buildbot-config step. 04:37:11 INFO - ##### 04:37:11 INFO - Running pre-action listener: _resource_record_pre_action 04:37:11 INFO - Running main action method: read_buildbot_config 04:37:11 INFO - Using buildbot properties: 04:37:11 INFO - { 04:37:11 INFO - "project": "", 04:37:11 INFO - "product": "firefox", 04:37:11 INFO - "script_repo_revision": "production", 04:37:11 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:37:11 INFO - "repository": "", 04:37:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:37:11 INFO - "buildid": "20160407043449", 04:37:11 INFO - "stage_platform": "macosx64", 04:37:11 INFO - "basedir": "/builds/slave/test", 04:37:11 INFO - "buildnumber": 14, 04:37:11 INFO - "platform": "yosemite_r7", 04:37:11 INFO - "mozci_request": { 04:37:11 INFO - "priority": -1, 04:37:11 INFO - "type": "trigger_all_talos_jobs", 04:37:11 INFO - "times": 6 04:37:11 INFO - }, 04:37:11 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:37:11 INFO - "slavebuilddir": "test", 04:37:11 INFO - "branch": "mozilla-central", 04:37:11 INFO - "revision": "68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8", 04:37:11 INFO - "slavename": "t-yosemite-r7-0050", 04:37:11 INFO - "builduid": "637956fa679e478c93a4ef2f21f58511", 04:37:11 INFO - "repo_path": "mozilla-central" 04:37:11 INFO - } 04:37:11 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg. 04:37:11 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:37:11 INFO - Running post-action listener: _resource_record_post_action 04:37:11 INFO - ##### 04:37:11 INFO - ##### Running download-and-extract step. 04:37:11 INFO - ##### 04:37:11 INFO - Running pre-action listener: _resource_record_pre_action 04:37:11 INFO - Running main action method: download_and_extract 04:37:11 INFO - mkdir: /builds/slave/test/build/tests 04:37:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:11 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.test_packages.json 04:37:11 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:37:11 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:37:12 INFO - Downloaded 1199 bytes. 04:37:12 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:37:12 INFO - Using the following test package requirements: 04:37:12 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:37:12 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:12 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 04:37:12 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:12 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 04:37:12 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:12 INFO - u'jsshell-mac.zip'], 04:37:12 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:12 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 04:37:12 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:37:12 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:12 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 04:37:12 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:12 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 04:37:12 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:12 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 04:37:12 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:12 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 04:37:12 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:37:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:12 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.common.tests.zip 04:37:12 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:37:12 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:37:16 INFO - Downloaded 17964225 bytes. 04:37:16 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:37:16 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:37:19 INFO - Return code: 0 04:37:19 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:37: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:37:19 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.common.tests.zip 04:37:19 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:37:19 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:37:20 INFO - Downloaded 17964225 bytes. 04:37:20 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:37:20 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:37:23 INFO - Return code: 0 04:37: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:37:23 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.talos.tests.zip 04:37:23 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:37:23 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:37:25 INFO - Downloaded 10847617 bytes. 04:37:25 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:37:25 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:37:25 INFO - Return code: 0 04:37:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:25 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg 04:37:25 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:37:25 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:37:45 INFO - Downloaded 108925595 bytes. 04:37:45 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:37:45 INFO - mkdir: /builds/slave/test/properties 04:37:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:37:45 INFO - Writing to file /builds/slave/test/properties/build_url 04:37:45 INFO - Contents: 04:37:45 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg 04:37:45 INFO - Running post-action listener: _resource_record_post_action 04:37:45 INFO - Running post-action listener: set_extra_try_arguments 04:37:45 INFO - ##### 04:37:45 INFO - ##### Running populate-webroot step. 04:37:45 INFO - ##### 04:37:45 INFO - Running pre-action listener: _resource_record_pre_action 04:37:45 INFO - Running main action method: populate_webroot 04:37:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:37:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:37:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:37:45 INFO - '--tppagecycles', 04:37:45 INFO - '7'], 04:37:45 INFO - 'tests': ['tsvgm']}}, 04:37:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:37:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:37:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:37:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:37:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:37:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:37:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['damp', 'tps']}, 04:37:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'tests': ['damp', 'tps']}, 04:37:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['dromaeo_dom']}, 04:37:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:37:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['a11yr', 04:37:45 INFO - 'ts_paint', 04:37:45 INFO - 'tpaint', 04:37:45 INFO - 'sessionrestore', 04:37:45 INFO - 'sessionrestore_no_auto_restore', 04:37:45 INFO - 'tabpaint']}, 04:37:45 INFO - 'other-e10s': {'tests': ['a11yr', 04:37:45 INFO - 'ts_paint', 04:37:45 INFO - 'tpaint', 04:37:45 INFO - 'sessionrestore', 04:37:45 INFO - 'sessionrestore_no_auto_restore', 04:37:45 INFO - 'tabpaint']}, 04:37:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:37:45 INFO - 'ts_paint', 04:37:45 INFO - 'tpaint', 04:37:45 INFO - 'sessionrestore', 04:37:45 INFO - 'sessionrestore_no_auto_restore', 04:37:45 INFO - 'tabpaint']}, 04:37:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:37:45 INFO - 'ts_paint', 04:37:45 INFO - 'tpaint', 04:37:45 INFO - 'sessionrestore', 04:37:45 INFO - 'sessionrestore_no_auto_restore', 04:37:45 INFO - 'tabpaint']}, 04:37:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['a11yr', 04:37:45 INFO - 'ts_paint', 04:37:45 INFO - 'tpaint', 04:37:45 INFO - 'sessionrestore', 04:37:45 INFO - 'sessionrestore_no_auto_restore', 04:37:45 INFO - 'tabpaint']}, 04:37:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['a11yr', 04:37:45 INFO - 'ts_paint', 04:37:45 INFO - 'tpaint', 04:37:45 INFO - 'sessionrestore', 04:37:45 INFO - 'sessionrestore_no_auto_restore', 04:37:45 INFO - 'tabpaint']}, 04:37:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['tsvgx', 04:37:45 INFO - 'tsvgr_opacity', 04:37:45 INFO - 'tart', 04:37:45 INFO - 'tscrollx', 04:37:45 INFO - 'cart']}, 04:37:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:37:45 INFO - 'tsvgr_opacity', 04:37:45 INFO - 'tart', 04:37:45 INFO - 'tscrollx', 04:37:45 INFO - 'cart']}, 04:37:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'talos_options': ['--disable-e10s'], 04:37:45 INFO - 'tests': ['tp5o']}, 04:37:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'tests': ['tp5o']}, 04:37:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'talos_options': ['--disable-e10s', 04:37:45 INFO - '--xperf_path', 04:37:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:37:45 INFO - 'tests': ['tp5n']}, 04:37:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:45 INFO - 'talos_options': ['--xperf_path', 04:37:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:37:45 INFO - 'tests': ['tp5n']}}, 04:37:45 INFO - 'talos.zip': {'path': '', 04:37:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:37:45 INFO - Running post-action listener: _resource_record_post_action 04:37:45 INFO - ##### 04:37:45 INFO - ##### Running create-virtualenv step. 04:37:45 INFO - ##### 04:37:45 INFO - Running pre-action listener: _resource_record_pre_action 04:37:45 INFO - Running main action method: create_virtualenv 04:37:45 INFO - Creating virtualenv /builds/slave/test/build/venv 04:37:45 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:37:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:37:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:37:45 INFO - Using real prefix '/tools/python27' 04:37:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:37:46 INFO - Installing distribute.............................................................................................................................................................................................done. 04:37:49 INFO - Installing pip.................done. 04:37:49 INFO - Return code: 0 04:37:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c9ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cac420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd019d8a930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b3be00>, '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 0x1009a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b36b20>, '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.yqNkGaBCtR/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.QNbrZt2xPh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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:37:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:37:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yqNkGaBCtR/Render', 04:37:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:49 INFO - 'HOME': '/Users/cltbld', 04:37:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:49 INFO - 'LOGNAME': 'cltbld', 04:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:49 INFO - 'MOZ_NO_REMOTE': '1', 04:37:49 INFO - 'NO_EM_RESTART': '1', 04:37:49 INFO - 'PAGER': '/bin/cat', 04:37:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:49 INFO - 'PWD': '/builds/slave/test', 04:37:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:49 INFO - 'SHELL': '/bin/bash', 04:37:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QNbrZt2xPh/Listeners', 04:37:49 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 04:37:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:49 INFO - 'USER': 'cltbld', 04:37:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:49 INFO - 'XPC_FLAGS': '0x0', 04:37:49 INFO - 'XPC_SERVICE_NAME': '0', 04:37:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:49 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:37:49 INFO - Cleaning up... 04:37:49 INFO - Return code: 0 04:37:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100c9ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cac420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd019d8a930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b3be00>, '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 0x1009a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b36b20>, '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.yqNkGaBCtR/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.QNbrZt2xPh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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:37:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:37:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yqNkGaBCtR/Render', 04:37:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:49 INFO - 'HOME': '/Users/cltbld', 04:37:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:49 INFO - 'LOGNAME': 'cltbld', 04:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:49 INFO - 'MOZ_NO_REMOTE': '1', 04:37:49 INFO - 'NO_EM_RESTART': '1', 04:37:49 INFO - 'PAGER': '/bin/cat', 04:37:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:49 INFO - 'PWD': '/builds/slave/test', 04:37:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:49 INFO - 'SHELL': '/bin/bash', 04:37:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QNbrZt2xPh/Listeners', 04:37:49 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 04:37:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:49 INFO - 'USER': 'cltbld', 04:37:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:49 INFO - 'XPC_FLAGS': '0x0', 04:37:49 INFO - 'XPC_SERVICE_NAME': '0', 04:37:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:49 INFO - Downloading/unpacking psutil>=0.7.1 04:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:37:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:37:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:37:53 INFO - Installing collected packages: psutil 04:37:53 INFO - Running setup.py install for psutil 04:37:53 INFO - building 'psutil._psutil_osx' extension 04:37:53 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:37:54 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:37:54 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:37:54 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:37:54 INFO - building 'psutil._psutil_posix' extension 04:37:54 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:37:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:37:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:37:54 INFO - ^ 04:37:54 INFO - 1 warning generated. 04:37:54 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:37:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:37:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:37:54 INFO - Successfully installed psutil 04:37:54 INFO - Cleaning up... 04:37:55 INFO - Return code: 0 04:37:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:55 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 0x100c9ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cac420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd019d8a930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b3be00>, '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 0x1009a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b36b20>, '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.yqNkGaBCtR/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.QNbrZt2xPh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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:37:55 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:37:55 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:37:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yqNkGaBCtR/Render', 04:37:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:55 INFO - 'HOME': '/Users/cltbld', 04:37:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:55 INFO - 'LOGNAME': 'cltbld', 04:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:55 INFO - 'MOZ_NO_REMOTE': '1', 04:37:55 INFO - 'NO_EM_RESTART': '1', 04:37:55 INFO - 'PAGER': '/bin/cat', 04:37:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:55 INFO - 'PWD': '/builds/slave/test', 04:37:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:55 INFO - 'SHELL': '/bin/bash', 04:37:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QNbrZt2xPh/Listeners', 04:37:55 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 04:37:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:55 INFO - 'USER': 'cltbld', 04:37:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:55 INFO - 'XPC_FLAGS': '0x0', 04:37:55 INFO - 'XPC_SERVICE_NAME': '0', 04:37:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:37:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:37:57 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:37:57 INFO - Installing collected packages: mozsystemmonitor 04:37:57 INFO - Running setup.py install for mozsystemmonitor 04:37:57 INFO - Successfully installed mozsystemmonitor 04:37:57 INFO - Cleaning up... 04:37:57 INFO - Return code: 0 04:37:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:37: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:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37: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:37:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37: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', '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 0x100c9ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cac420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd019d8a930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b3be00>, '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 0x1009a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b36b20>, '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.yqNkGaBCtR/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.QNbrZt2xPh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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:37: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:37: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 blobuploader==1.2.4 04:37:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yqNkGaBCtR/Render', 04:37:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:57 INFO - 'HOME': '/Users/cltbld', 04:37:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:57 INFO - 'LOGNAME': 'cltbld', 04:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:57 INFO - 'MOZ_NO_REMOTE': '1', 04:37:57 INFO - 'NO_EM_RESTART': '1', 04:37:57 INFO - 'PAGER': '/bin/cat', 04:37:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:57 INFO - 'PWD': '/builds/slave/test', 04:37:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:57 INFO - 'SHELL': '/bin/bash', 04:37:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QNbrZt2xPh/Listeners', 04:37:57 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 04:37:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:57 INFO - 'USER': 'cltbld', 04:37:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:57 INFO - 'XPC_FLAGS': '0x0', 04:37:57 INFO - 'XPC_SERVICE_NAME': '0', 04:37:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:58 INFO - Downloading/unpacking blobuploader==1.2.4 04:37:58 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:37:58 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:37:58 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:37:58 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:37:58 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:37:58 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:38:00 INFO - Downloading blobuploader-1.2.4.tar.gz 04:38:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:38:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:38:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:01 INFO - Downloading docopt-0.6.1.tar.gz 04:38:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:38:01 INFO - Installing collected packages: blobuploader, requests, docopt 04:38:01 INFO - Running setup.py install for blobuploader 04:38:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:38:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:38:02 INFO - Running setup.py install for requests 04:38:02 INFO - Running setup.py install for docopt 04:38:02 INFO - Successfully installed blobuploader requests docopt 04:38:02 INFO - Cleaning up... 04:38:02 INFO - Return code: 0 04:38:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:02 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 0x100c9ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cac420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd019d8a930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b3be00>, '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 0x1009a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b36b20>, '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.yqNkGaBCtR/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.QNbrZt2xPh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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:38:02 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:38:02 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:38:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yqNkGaBCtR/Render', 04:38:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:02 INFO - 'HOME': '/Users/cltbld', 04:38:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:02 INFO - 'LOGNAME': 'cltbld', 04:38:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:02 INFO - 'MOZ_NO_REMOTE': '1', 04:38:02 INFO - 'NO_EM_RESTART': '1', 04:38:02 INFO - 'PAGER': '/bin/cat', 04:38:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:02 INFO - 'PWD': '/builds/slave/test', 04:38:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:02 INFO - 'SHELL': '/bin/bash', 04:38:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QNbrZt2xPh/Listeners', 04:38:02 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 04:38:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:02 INFO - 'USER': 'cltbld', 04:38:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:02 INFO - 'XPC_FLAGS': '0x0', 04:38:02 INFO - 'XPC_SERVICE_NAME': '0', 04:38:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:38:03 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-KMdzYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:38:03 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-6FL7qP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:38:03 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-H6uE3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:38:03 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-pxsgyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:38:03 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-99hWab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:38:03 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-c5EzUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:38:03 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-XN2GV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:38:03 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-BsAwIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:38:03 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-MwVhwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:38:04 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-MwbIvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:38:04 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-1cZDgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:38:04 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-A9VTUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:38:04 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-yCvjSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:38:04 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-zTEUT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:04 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-D_AnmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:38:04 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-MwV12n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:38:04 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-HPRrSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:38:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:38:04 INFO - Running setup.py install for manifestparser 04:38:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:38:05 INFO - Running setup.py install for mozcrash 04:38:05 INFO - Running setup.py install for mozdebug 04:38:05 INFO - Running setup.py install for mozdevice 04:38:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:38:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:38:05 INFO - Running setup.py install for mozfile 04:38:05 INFO - Running setup.py install for mozhttpd 04:38:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:38:05 INFO - Running setup.py install for mozinfo 04:38:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:38:05 INFO - Running setup.py install for mozInstall 04:38:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:38:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:38:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:38:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:38:06 INFO - Running setup.py install for mozleak 04:38:06 INFO - Running setup.py install for mozlog 04:38:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:38:06 INFO - Running setup.py install for moznetwork 04:38:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:38:06 INFO - Running setup.py install for mozprocess 04:38:06 INFO - Running setup.py install for mozprofile 04:38:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:38:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:38:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:38:06 INFO - Running setup.py install for mozrunner 04:38:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:38:06 INFO - Running setup.py install for mozscreenshot 04:38:07 INFO - Running setup.py install for moztest 04:38:07 INFO - Running setup.py install for mozversion 04:38:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:38:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:38:07 INFO - Cleaning up... 04:38:07 INFO - Return code: 0 04:38:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:07 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 0x100c9ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cac420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd019d8a930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b3be00>, '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 0x1009a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b36b20>, '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.yqNkGaBCtR/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.QNbrZt2xPh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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:38:07 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:38:07 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:38:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yqNkGaBCtR/Render', 04:38:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:07 INFO - 'HOME': '/Users/cltbld', 04:38:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:07 INFO - 'LOGNAME': 'cltbld', 04:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:07 INFO - 'MOZ_NO_REMOTE': '1', 04:38:07 INFO - 'NO_EM_RESTART': '1', 04:38:07 INFO - 'PAGER': '/bin/cat', 04:38:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:07 INFO - 'PWD': '/builds/slave/test', 04:38:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:07 INFO - 'SHELL': '/bin/bash', 04:38:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QNbrZt2xPh/Listeners', 04:38:07 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 04:38:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:07 INFO - 'USER': 'cltbld', 04:38:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:07 INFO - 'XPC_FLAGS': '0x0', 04:38:07 INFO - 'XPC_SERVICE_NAME': '0', 04:38:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:38:07 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-FMIfop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:38:07 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:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:38:07 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-ZOwilp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:38:07 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:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:38:07 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-W_CJtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:38:07 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:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:38:08 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-3Cu61w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:38:08 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:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:38:08 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-UQHx9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:38:08 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:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:38:08 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-Pm8kT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:38:08 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:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:38:08 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-ycDVtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:38:08 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:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:38:08 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-As0xD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:38:08 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:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:38:08 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-OWjeqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:38:08 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:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:38:08 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-r00zUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:38:08 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:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:38:08 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-DvtTr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:38:08 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:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:38:08 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-H2LEnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:38:08 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:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:38:08 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-9bsMbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:38:09 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:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:38:09 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-T4FqbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:38:09 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:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:09 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-s8yDYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:09 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:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:38:09 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-KaTYgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:38:09 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:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:38:09 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-w1xWIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:38:09 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:38:09 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:38:09 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:38:09 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:38:09 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:38:09 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:38:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:11 INFO - Downloading blessings-1.6.tar.gz 04:38:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:38:11 INFO - Installing collected packages: blessings 04:38:11 INFO - Running setup.py install for blessings 04:38:12 INFO - Successfully installed blessings 04:38:12 INFO - Cleaning up... 04:38:12 INFO - Return code: 0 04:38:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:38:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:38:12 INFO - Reading from file tmpfile_stdout 04:38:12 INFO - Current package versions: 04:38:12 INFO - blessings == 1.6 04:38:12 INFO - blobuploader == 1.2.4 04:38:12 INFO - docopt == 0.6.1 04:38:12 INFO - manifestparser == 1.1 04:38:12 INFO - mozInstall == 1.12 04:38:12 INFO - mozcrash == 0.17 04:38:12 INFO - mozdebug == 0.1 04:38:12 INFO - mozdevice == 0.48 04:38:12 INFO - mozfile == 1.2 04:38:12 INFO - mozhttpd == 0.7 04:38:12 INFO - mozinfo == 0.9 04:38:12 INFO - mozleak == 0.1 04:38:12 INFO - mozlog == 3.1 04:38:12 INFO - moznetwork == 0.27 04:38:12 INFO - mozprocess == 0.22 04:38:12 INFO - mozprofile == 0.28 04:38:12 INFO - mozrunner == 6.11 04:38:12 INFO - mozscreenshot == 0.1 04:38:12 INFO - mozsystemmonitor == 0.0 04:38:12 INFO - moztest == 0.7 04:38:12 INFO - mozversion == 1.4 04:38:12 INFO - psutil == 3.1.1 04:38:12 INFO - requests == 1.2.3 04:38:12 INFO - wsgiref == 0.1.2 04:38:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:12 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 0x100c9ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cac420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd019d8a930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b3be00>, '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 0x1009a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b36b20>, '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.yqNkGaBCtR/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.QNbrZt2xPh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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:38:12 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:38:12 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:38:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yqNkGaBCtR/Render', 04:38:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:12 INFO - 'HOME': '/Users/cltbld', 04:38:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:12 INFO - 'LOGNAME': 'cltbld', 04:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:12 INFO - 'MOZ_NO_REMOTE': '1', 04:38:12 INFO - 'NO_EM_RESTART': '1', 04:38:12 INFO - 'PAGER': '/bin/cat', 04:38:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:12 INFO - 'PWD': '/builds/slave/test', 04:38:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:12 INFO - 'SHELL': '/bin/bash', 04:38:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QNbrZt2xPh/Listeners', 04:38:12 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 04:38:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:12 INFO - 'USER': 'cltbld', 04:38:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:12 INFO - 'XPC_FLAGS': '0x0', 04:38:12 INFO - 'XPC_SERVICE_NAME': '0', 04:38:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:12 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:38:12 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:38:12 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:38:12 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:38:12 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:38:12 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:38:12 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:38:12 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:38:12 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:38:12 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:38:12 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:38:12 INFO - Cleaning up... 04:38:12 INFO - Return code: 0 04:38:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:12 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 0x100c9ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cac420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd019d8a930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b3be00>, '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 0x1009a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b36b20>, '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.yqNkGaBCtR/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.QNbrZt2xPh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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:38:12 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:38:12 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:38:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yqNkGaBCtR/Render', 04:38:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:12 INFO - 'HOME': '/Users/cltbld', 04:38:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:12 INFO - 'LOGNAME': 'cltbld', 04:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:12 INFO - 'MOZ_NO_REMOTE': '1', 04:38:12 INFO - 'NO_EM_RESTART': '1', 04:38:12 INFO - 'PAGER': '/bin/cat', 04:38:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:12 INFO - 'PWD': '/builds/slave/test', 04:38:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:12 INFO - 'SHELL': '/bin/bash', 04:38:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QNbrZt2xPh/Listeners', 04:38:12 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 04:38:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:12 INFO - 'USER': 'cltbld', 04:38:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:12 INFO - 'XPC_FLAGS': '0x0', 04:38:12 INFO - 'XPC_SERVICE_NAME': '0', 04:38:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:13 INFO - Downloading/unpacking jsonschema 04:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:38:15 INFO - Downloading/unpacking functools32 (from jsonschema) 04:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:15 INFO - Downloading functools32-3.2.3-2.tar.gz 04:38:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:38:15 INFO - warning: no files found matching '*.txt' 04:38:15 INFO - no previously-included directories found matching 'build' 04:38:15 INFO - no previously-included directories found matching 'dist' 04:38:15 INFO - no previously-included directories found matching '.git*' 04:38:15 INFO - Installing collected packages: jsonschema, functools32 04:38:15 INFO - Running setup.py install for functools32 04:38:16 INFO - warning: no files found matching '*.txt' 04:38:16 INFO - no previously-included directories found matching 'build' 04:38:16 INFO - no previously-included directories found matching 'dist' 04:38:16 INFO - no previously-included directories found matching '.git*' 04:38:16 INFO - Successfully installed jsonschema functools32 04:38:16 INFO - Cleaning up... 04:38:16 INFO - Return code: 0 04:38:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:38:16 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:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:16 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:38:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:16 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 0x100c9ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cac420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd019d8a930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b3be00>, '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 0x1009a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b36b20>, '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.yqNkGaBCtR/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.QNbrZt2xPh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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:38:16 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:38:16 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:38:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yqNkGaBCtR/Render', 04:38:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:16 INFO - 'HOME': '/Users/cltbld', 04:38:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:16 INFO - 'LOGNAME': 'cltbld', 04:38:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:16 INFO - 'MOZ_NO_REMOTE': '1', 04:38:16 INFO - 'NO_EM_RESTART': '1', 04:38:16 INFO - 'PAGER': '/bin/cat', 04:38:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:16 INFO - 'PWD': '/builds/slave/test', 04:38:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:16 INFO - 'SHELL': '/bin/bash', 04:38:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QNbrZt2xPh/Listeners', 04:38:16 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 04:38:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:16 INFO - 'USER': 'cltbld', 04:38:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:16 INFO - 'XPC_FLAGS': '0x0', 04:38:16 INFO - 'XPC_SERVICE_NAME': '0', 04:38:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:16 INFO - Downloading/unpacking flake8 04:38: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:38: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:38: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:38: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:38: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:38: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:38:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:38:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:38:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:38:19 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:38:19 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:38:19 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:38:19 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:38:19 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:38:19 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:38:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:38:19 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:38:19 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:38:19 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:38:19 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:38:19 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:38:19 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:38:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:38:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:38:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:38:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:38:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:38:20 INFO - no previously-included directories found matching 'docs/_build' 04:38:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:38:20 INFO - Running setup.py install for pep8 04:38:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:38:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:38:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:38:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:38:20 INFO - no previously-included directories found matching 'docs/_build' 04:38:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:38:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:38:20 INFO - Cleaning up... 04:38:20 INFO - Return code: 0 04:38:20 INFO - Running post-action listener: _resource_record_post_action 04:38:20 INFO - Running post-action listener: _start_resource_monitoring 04:38:20 INFO - Starting resource monitoring. 04:38:20 INFO - ##### 04:38:20 INFO - ##### Running install step. 04:38:20 INFO - ##### 04:38:20 INFO - Running pre-action listener: _resource_record_pre_action 04:38:20 INFO - Running main action method: install 04:38:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:38:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:38:20 INFO - Reading from file tmpfile_stdout 04:38:20 INFO - Detecting whether we're running mozinstall >=1.0... 04:38:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:38:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:38:20 INFO - Reading from file tmpfile_stdout 04:38:20 INFO - Output received: 04:38:20 INFO - Usage: mozinstall [options] installer 04:38:20 INFO - Options: 04:38:20 INFO - -h, --help show this help message and exit 04:38:20 INFO - -d DEST, --destination=DEST 04:38:20 INFO - Directory to install application into. [default: 04:38:20 INFO - "/builds/slave/test"] 04:38:20 INFO - --app=APP Application being installed. [default: firefox] 04:38:20 INFO - mkdir: /builds/slave/test/build/application 04:38:20 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:38:20 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:38:54 INFO - Reading from file tmpfile_stdout 04:38:54 INFO - Output received: 04:38:54 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:38:54 INFO - Running post-action listener: _resource_record_post_action 04:38:54 INFO - ##### 04:38:54 INFO - ##### Running run-tests step. 04:38:54 INFO - ##### 04:38:54 INFO - Running pre-action listener: _resource_record_pre_action 04:38:54 INFO - Running main action method: run_tests 04:38:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:38:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:38:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:38:54 INFO - 2016-04-07 04:38:54.523 screenresolution[1672:8104] starting screenresolution argv=screenresolution get 04:38:54 INFO - 2016-04-07 04:38:54.526 screenresolution[1672:8104] Display 0: 1600x1200x32@60 04:38:54 INFO - 2016-04-07 04:38:54.532 screenresolution[1673:8106] starting screenresolution argv=screenresolution list 04:38:54 INFO - Available Modes on Display 0 04:38:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:38:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:38:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:38:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:38:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:38:54 INFO - Intel Iris: 04:38:54 INFO - Chipset Model: Intel Iris 04:38:54 INFO - Type: GPU 04:38:54 INFO - Bus: Built-In 04:38:54 INFO - VRAM (Dynamic, Max): 1536 MB 04:38:54 INFO - Vendor: Intel (0x8086) 04:38:54 INFO - Device ID: 0x0a2e 04:38:54 INFO - Revision ID: 0x0009 04:38:54 INFO - Displays: 04:38:54 INFO - Display: 04:38:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:38:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:38:54 INFO - Display Serial Number: 1600x1200 60 04:38:54 INFO - Main Display: Yes 04:38:54 INFO - Mirror: Off 04:38:54 INFO - Online: Yes 04:38:54 INFO - Rotation: Supported 04:38:54 INFO - Return code: 0 04:38:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:38:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:38:54 INFO - Python 2.7.3 04:38:54 INFO - Return code: 0 04:38:54 INFO - grabbing minidump binary from tooltool 04:38:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:54 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 0x100b3be00>, '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 0x1009a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b36b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:38:54 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:38:54 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:38:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:38:54 INFO - Return code: 0 04:38:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:38:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:38:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:38:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:38:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:38:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:38:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:38:56 INFO - Return code: 0 04:38:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', '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-0050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:38:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath 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-0050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:38:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yqNkGaBCtR/Render', 04:38:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:56 INFO - 'HOME': '/Users/cltbld', 04:38:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:56 INFO - 'LOGNAME': 'cltbld', 04:38:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:38:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:56 INFO - 'MOZ_NO_REMOTE': '1', 04:38:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:38:56 INFO - 'NO_EM_RESTART': '1', 04:38:56 INFO - 'PAGER': '/bin/cat', 04:38:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:56 INFO - 'PWD': '/builds/slave/test', 04:38:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:38:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:56 INFO - 'SHELL': '/bin/bash', 04:38:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QNbrZt2xPh/Listeners', 04:38:56 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 04:38:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:56 INFO - 'USER': 'cltbld', 04:38:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:56 INFO - 'XPC_FLAGS': '0x0', 04:38:56 INFO - 'XPC_SERVICE_NAME': '0', 04:38:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', '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-0050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:38:56 INFO - mozversion application_buildid: 20160406030021 04:38:56 INFO - mozversion application_changeset: 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 04:38:56 INFO - mozversion application_display_name: Nightly 04:38:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:38:56 INFO - mozversion application_name: Firefox 04:38:56 INFO - mozversion application_remotingname: firefox 04:38:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:38:56 INFO - mozversion application_vendor: Mozilla 04:38:56 INFO - mozversion application_version: 48.0a1 04:38:56 INFO - mozversion platform_buildid: 20160406030021 04:38:56 INFO - mozversion platform_changeset: 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 04:38:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:38:56 INFO - mozversion platform_version: 48.0a1 04:38:56 INFO - using testdate: 1460029136 04:38:56 INFO - actual date: 1460029136 04:38:56 INFO - starting webserver on 'localhost:49265' 04:38:56 INFO - SUITE-START | Running 2 tests 04:38:56 INFO - TEST-START | dromaeo_css 04:38:56 INFO - operating with platform_type : mac_ 04:38:56 INFO - Initialising browser for dromaeo_css test... 04:38:56 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmphMEiTu/profile http://localhost:49265/getInfo.html) 04:38:58 INFO - PROCESS | 1691 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 04:38:59 INFO - PROCESS | 1691 | __metrics Screen width/height:1600/1200 04:38:59 INFO - PROCESS | 1691 | colorDepth:24 04:38:59 INFO - PROCESS | 1691 | Browser inner width/height: 1024/689 04:38:59 INFO - PROCESS | 1691 | __metrics 04:38:59 ERROR - PROCESS | 1691 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 04:38:59 INFO - TEST-INFO | 1691: exit 0 04:38:59 INFO - Browser initialized. 04:38:59 INFO - Running cycle 1/1 for dromaeo_css test... 04:38:59 INFO - TEST-INFO | started process 1695 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmphMEiTu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:39:11 INFO - PROCESS | 1695 | RSS: Main: 246943744 04:39:11 INFO - PROCESS | 1695 | 04:40:01 INFO - PROCESS | 1695 | 1460029201491 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:42:12 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49265/tests/dromaeo/cssquery-ext.html) 04:42:14 INFO - PROCESS | 1695 | RSS: Main: 258260992 04:42:14 INFO - PROCESS | 1695 | 04:45:16 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-ext.html (next: http://localhost:49265/tests/dromaeo/cssquery-jquery.html) 04:45:17 INFO - PROCESS | 1695 | RSS: Main: 271044608 04:45:17 INFO - PROCESS | 1695 | 04:48:18 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49265/tests/dromaeo/cssquery-mootools.html) 04:48:19 INFO - PROCESS | 1695 | RSS: Main: 272748544 04:48:19 INFO - PROCESS | 1695 | 04:51:21 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49265/tests/dromaeo/cssquery-prototype.html) 04:51:21 INFO - PROCESS | 1695 | RSS: Main: 276684800 04:51:21 INFO - PROCESS | 1695 | 04:54:24 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49265/tests/dromaeo/cssquery-yui.html) 04:54:24 INFO - PROCESS | 1695 | RSS: Main: 275886080 04:54:24 INFO - PROCESS | 1695 | 04:57:27 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-yui.html (next: http://localhost:49265/tests/dromaeo/cssquery-dojo.html) 04:57:27 INFO - PROCESS | 1695 | RSS: Main: 279486464 04:57:27 INFO - PROCESS | 1695 | 04:57:27 INFO - PROCESS | 1695 | __start_tp_report 04:57:27 INFO - PROCESS | 1695 | _x_x_mozilla_page_load 04:57:27 INFO - PROCESS | 1695 | _x_x_mozilla_page_load_details 04:57:27 INFO - PROCESS | 1695 | |i|pagename|runs| 04:57:27 INFO - PROCESS | 1695 | |0;dojo.html;3504.8773292934743;3541.3625547401457;3597.3165098631275;3608.9278214435712;3613.1689711366384;5660.801871934483;5701.315842098944;5754.942450575493;5759.337676167237;5777.45114214149;4718.725943995119;5710.000749868777;5774.191613174148;5864.648121112737;5871.765129394819;4258.871399079247;5143.717095559743;5168;5225.216217567377;5277.287566178555;4558.566936141078;4567.451905771312;4980.576650984671;5295.0733621616255;5349.759260833272;5101.464346243665;5130.897382052375;5180.611454140954;5202.323697919246;5275.683458992454;5179.171332586768;5186.325777648919;5196.558292545138;5210.426853046162;5248.790048398059;5162.638615296931;5170.741462926839;5179.689218646893;5191.0656081905245;5243.973780131075;5555.972220138914;5653.293338332708;5658.377578466366;5708.200851880699;5716.828495145152;6154;6189.257289125334;6214.042576588406;6223.315435302113;6244.531660125509;6177;6235.501159907197;6244.0009598464485;6247.937520624781;6313.273973493061;4675.95324046762;5741.971290143522;5851.4148585141575;5859.53123750099;5959.046552551571;6223.626582405071;6288.748450062038;6292.590981586182;6305.747770089145;6323.841903952346;4582.518835522222;6156.445919867144;6175.3824617538785;6184.536159788034;6220.284667263232;6133.6319820810895;6176.7838125665385;6216.658083805343;6276.058591211264;6279.497640188774;6052.939470605325;6119.25883887406;6172.22847144107;6212.099245609361;6216.378362163838;6185.597936134137;6226.6575338355915;6245.78207249582;6250.531210159256;6256.499480041586;4838.153323168502;4900.950990490121;4924.03981223658;4931.679440836334;4987.725675087905;4407.338899165086;4414.09511050234;4421.292593185075;4425.933610995838;4431.224535706238;5650.943490565124;5772.913406298909;5779.942200577941;5791;5847.181394604759;5444.428335024844;6290.591111577733;6312.400321969406;6319.241690997018;6321.589096708699;4846.975765121152;5675.177099320658;5730.74211660468;5797.420257974169;5802.564807639444;5338.519533241949;5396;5439.5920305976415;5446.700431476307;5447.319085114361;6331.113644089831;6374.968125159345;6382.170317858741;6392.776252831129;6486.286508484157;5203.427622961547;6205.906911396242;6320.083587879823;6321.862064828375;6350.237971443272;6193.81418557444;6301.747930082745;6337.366263373626;6355.30091689923;6395.744170233139;6185.907211391743;6232.844178895564;6252.5935814171935;6273.498120150468;6281.685915704288;6140.232470941132;6237.844053898689;6295.874082518416;6323.399277068671;6348.841278968062;5983.34183239852;6017;6085.1480792689945;6105.732692890381;6197.380261973766;5992.191054207626;6028.457438830526;6110.194261626774;6125.448709616156;6129.509639228941;5883.646761244852;5946.732397042057;5957.642541447527;5971.880562388815;6096.420840020369;6083.061604606031;6114.728311729558;6135.508280839814;6148.862460444832;6189.257289125334;5953.28560572734;6046.637201767908;6051.062085376773;6077.4834139098675;6112.2970858351855 04:57:27 INFO - PROCESS | 1695 | |1;ext.html;472.46611329198004;561.9016672082382;571.9142128680697;576.8520643918603;623.2365352443256;33549.83225083874;37524;37574.87275381736;37626.8118659407;37819.81090094546;39439;40192.19615607686;40779;40828.59171408285;40925.795371023174;9403.670871519482;9454.763630909214;9535.189508891752;9662.178714809215;9691.806163876718;8161.183881611821;9471.194948429358;9526.28552858535;9661.227101831837;9679.467629280387;9548.140667339938;9573.42559446432;9684.225261979025;9693.273004524654;9706.126448619623;9590.040995900425;9597.376170548892;9617.615295388176;9693.3699309545;9693.757656058584;9466.810663786755;9510.429374237568;9559.856602150974;9582.041795820362;9619.663311784125;37146.699865504575;37160.81419592912;37220.627793721986;37538.249235015144;37859;2949.6165498485275;3064.3718037802196;3161;3163.810171389701;3311.1887587541205;27038.864805676043;27260.59109113365;27922.860385697943;27973.160805175674;28070.017549385877;2683.409649877024;2696.1237597780605;2723.237493501823;2839.730225628562;2906.084583356257;435969;461829.2176852016;489287;493000;495618;66810.99783503251;67289;67310;67316.66341668359;67327.66336168288;68081.65959170173;69395;70964;71659.92510112353;72810.81567552983;11839.88160118405;16090;16152.35390584387;16334;16398.09810460436;9771;12229.877701223051;12300.446479908425;12722.936385318015;12807.295598741972;20062;20488.18047278092;20543.691844622343;20741.481462963548;20742.89628551878;7429;8152.755417337489;8556.957215214008;8762.458886922848;9054.637814487478;785.0265670568454;994.9303548751662;1021.2493817044466;1053.910417614496;1114.4427786106946;25133;28780.136595902157;28893.42213155725;29699.85150074236;29901.25246868802;1052.2423854824515;1088.9346639201674;1113.8273567597034;1120.3949867071854;1149.9252548584316;13002.699730026921;13408.798868016987;14577;14888.106713597219;14985.775213371808;504455;507328;509246;511041;511338;55916;56110;56210.43789562134;56718;56961;1428.2073449235565;1467.6771110355705;1470.1105830972322;1472.0873058703671;1481.4000329866421;28377.034019046172;28453.573196402485;28971.42057158887;29469.852650736608;29505;48886.75556622194;48936.26595600998;49023.26465102955;49068.26397603967;49446.50553494563;465283;465475;467004;467789;470183;31561.210969725023;32976.34047319088;33041.33917321688;33531.32937341288;33590.832045840594;41965.60343071297;44270;44411.77794111138;45062.77468612767;45350.319745204506;35797.82101089478;37143.44284835784;37420;37725.62274377221;37818.62181378151;35939;36047.81976090103;36212.27575448529;37011.259774804894;37053.25893482062;30837.383252335276;36847.44728829016;36988.44517332188;37491.62508374881;38399.84800455879;32064.717411303285;33309.66690333065;33599.664003359656;33659.50282262019;33718;24287.392815179763;24310.63534047026;24379.26862194137;24986.125485607918;25023.87488062548 04:57:27 INFO - PROCESS | 1695 | |2;jquery.html;347.95650543682024;358.34244161962806;358.8582509908586;361.95113659655937;363.73447383410127;19556.41330760078;19717.901410492945;20742.585148297025;20974.790252097475;21272.14911403546;16805.83194168058;19706.310279140234;20095.698564521543;20837.270695525658;21049.684254736192;4854;5024.924626130611;5158.380994280673;5267.3942496613;5339.866503337409;3898.8245528951124;5250.343707036621;5652;5895.174675545427;5897.528197744192;5769.105788602773;5784.595078344518;5852.063669812831;5901.439363260483;5909.113632955048;5815.09147559319;6376.7130479128555;6547.345265473438;6569.835754106138;6572.047053177311;5565.582581306418;5586.413426590231;5677.971610141964;5727.198192253088;5729.083346664555;13304.667383315495;13584.524541640994;13626.659333516642;13649.317534123255;14171.220582867938;1910.360029390156;2032.9593408131755;2159.3198142585034;2300.5283916797016;2467.546613064522;8393.580320983987;9375.390599611004;9478.336516443851;10030;10043.397396156253;1650.7276299410582;1749.3877142999847;1759.1995641982867;1760.3838656470261;1762.6122253104425;95059;101711.982880171;102098;103458;104799.95200048054;10931.234813563133;10934.507947142398;10992.780144397228;11048.226624136234;11049.337039777478;13120.475180992653;13181.340932953506;13194.934025330003;13389.928805695521;13563.864361356458;6463.870722585522;6471.449926756184;7844.4901081429525;8379.916200837913;8455.154484551618;8315.58635032046;8485.915140848636;8573.056963733985;8626.698065567674;8649.437786543855;3669.412893936957;4327.307630779123;4340.262155433584;4370.344448332776;4433.8669839904205;1723.8793284469966;1723.922423490921;1806.5972256898294;1812.7099664053687;1840.401869392453;935.2284365398573;970.1317320997667;993.7962717642865;1023.2121266624806;1064.7338165458636;16176.75734863978;19400.126994285292;19737.802621973595;19917.00414979274;20033;975.5414954971152;982.6855406270068;992.9404235745878;1049.1030169205371;1063.9893601064045;10403.739906502247;11001.284916480403;11004.064654504456;11072.444801364176;11120.054795342325;556862;562893;562914;573542;575435;108481;109212.45393773139;110037.44981275042;112625.43687281675;114427;1013.3717095400751;1035.316690983947;1041.1150522056344;1043.2436483549366;1057.8836328003913;15762.448314308944;17891.910540447214;17938.5515362117;18217.817821821613;18479.891206527653;47468.52531474779;47512.4650431426;48528.5147148524;48662.27006594975;48772;68220.6588967052;68796.6560167216;69131;69207;69604.95592566217;7710.7686769397005;7832.138464768757;7904;7986.121526632182;8167.469114507538;9240.306976976619;11228.606998755004;12100.273983561014;12611.243325400505;12744.299063551594;10846.783064338826;10850.67447976562;10954.671359859218;10984.01143897053;11038.44807759625;8727.869081963903;10875.347479151276;10953.356996450277;11188.72028199269;11236.213465057368;10686.145108391154;10995.34027958325;11088.889111108785;11257.155713321697;11284.379359135326;7803.102643195878;7814.726484573012;7816.72641457569;7837.960810195913;7871.921280787119;9292.16370526656;10732.356058636507;10888.891111088788;10899.237053406185;11097.833532496858 04:57:27 INFO - PROCESS | 1695 | |3;mootools.html;1572.9134897580632;1598.1449924290507;1868.327402135231;1962.5093726568357;1983.3554094919145;7856.332211761993;8566.143385661439;8593.398462107654;8786.516741579211;8805.911940880596;8558.015828179761;8601.18288762568;8674.479531228131;8680.435771674836;8701.521416322099;2442.1086303499274;2445.156421034749;2451.7915977141965;2454.325060608338;2490.991148584826;2377.1679912030736;2443;2473.418746594549;2506.1729629222405;2511.573032584456;2462.3105530451503;2469.962950555743;2476.071473197551;2501.3371456564023;2517.2070797698757;2448.816338774599;2457.336519139831;2467.76556227159;2469.2221950085664;2497.900083996647;2420.2739178246457;2465.359006658282;2491.7757401833924;2492.401823562332;2506.724260331362;8761.737147885573;8794.03265640779;8824.470531768051;8831.249343805785;8842.867356989651;5364;5372.221027950925;5379.9778042171865;5409.6213265071465;5499.917501237484;3547.840347184357;3635.381985062546;3639.5632524097014;3650.324689932371;3724.087598538348;1015.3907655406697;1041.2138835179467;1050.8738951325813;1052.074174726236;1058.3120971368594;10727.678169654922;11103.222774405795;11576.305421674642;11929.761404771943;11938.582149624808;4800.615950723934;4875.585575226075;4944.629152813553;4963.404391472975;4988.575971042429;8376.581170941428;10042.447665378475;10109.090181883666;10122;10138.087572118397;5431.402545719968;5450.945490545044;5456.317960254968;5510.1459273812625;5511.972440137773;4508.729476231371;4869.391326084239;4916.213405855046;4974.403071631427;5000.724960127228;3904.4533765272886;3963.7621742694955;4022.255882661717;4033.153037862023;4106.425100485934;1307.3659275251496;1308.8429388473253;1317.7891537353978;1326.7346530693708;1353.477337994756;1371.0128707330705;1374.8212732344732;1375.9449622015206;1395.448797724893;1409.401004573073;8256.587170641564;8315.667373305;8321.043080045873;8336.416450848503;8368.58157092143;503.0969409909222;504.96717713348517;511.16934980656436;512.0552580488992;512.6718899904064;6204.875902481925;6243.906341404882;6279.937200628026;6280.528960327993;6284.842878928063;8883.511406872554;10190.133838623651;10455.268131230892;10458.111060559937;10484.26610137283;10341;10344.37933723964;10397.11624511925;10441.164706823436;10449.425281609432;7823.647935842901;7992.280694737386;8011.959940200261;8063.4355595108955;8243.546604936666;7960.363170946194;7997;8047;8126.55303958288;8128.431009829492;9140.360174787702;9251.213646839824;9391.29565282593;9506.191973682315;9619.51902404863;9337;9780.559874805509;9838.262130340396;9987.101160895554;10008.749781255527;5887;7006.719731210695;7198;7556.055493063367;7638.847223055619;6810.148731408574;7422.369098626677;7587.58268295249;8103.87844182326;8225.5475948821;6643.30245324234;7310.780676579711;7344.522606030591;7419.443541734499;7530.736424225126;7256.238094999949;7257.802462593824;7264.67308971087;7345.045144131229;7458.664360103699;7039.8944015840825;7724.382049436144;7755.185705500841;7759.146493885781;7767.572783496962;7004.124484439445;7005.579665220103;7041.084658994298;7049.647517624201;7051.682674279567;6962.338577835098;7026.613536255555;7109.2179860216365;7117.252688467844;7133.179684336368 04:57:27 INFO - PROCESS | 1695 | |4;prototype.html;301.93961207758446;323.1904080278901;326.26752939650487;330.6329973729159;331.21667256937343;5243.842684719464;6518.445932095771;6565;6620.668966551677;6642.734290628375;5228.895422091556;6495.253045899723;6558.409743123118;6591.274959754423;6618.735250589971;4587.105514424688;4662.463816661094;4856.125897338477;4865.905171336456;4876.536729010738;4835.815225269814;4854.1990571555825;4855.223164293714;4864.975675121619;4868.853934381957;4791.664583479158;4792.137415265251;4800.615950723951;4818.084563932859;4829.396325459317;4815.398075240595;4817.373741413611;4819.421669399677;4830.227163653799;4842.757862106916;4144.33690609501;4172.520160181588;4174.624283814441;4175.164967006581;4184.51878034027;4993.975030124862;5329.8274379636805;5951.791687290967;6278.78024269153;6312.684365781738;5363.249145119687;5577.498025177753;5578.023845826964;5599.972000140014;5609.467100625434;6947.861042779116;6986.196587392464;6989.266127056637;6989.580625162455;7006.684699188549;3687.3547129252543;4526.6831321807485;4541.159885421208;4551.2262915304145;4562.657800664931;6239.344868788758;7072.115985501812;7324.926750732478;7393.778186654409;7436.66535005926;4345.543717909637;4488.64090872736;4504.09918016398;4572.428446444194;4581.725096494154;4658.697184682985;4695.43654761424;4699.624030077585;4702.576768090888;4718.9292160617615;4486;5546.417626149277;5546.833594992157;5557.3331200256225;5605.691686957257;6985.860282794316;6989.615571143636;7023.262557431498;7026.9648651756415;7041.295870412918;1267.8668739782374;1299.0581828174686;1409.943602255919;1605.3257631794675;1642.909639969813;1000.884898236712;1008.6318493749875;1049.3284298049255;1050.9159267258601;1055.0504545908743;5514.365847927459;5859.886621541893;5898.970505147447;6506.219253689493;6515.967420162963;7310.671019804122;7341.375983041395;7348.926510734931;7353.374963128087;7368.594727289943;6418.871622567616;6438.7102580384;6450.645214513247;6481.09264702942;6503.28463868974;3839.0978120141745;3869.4776205212497;3892.746971446847;3894.805259737002;3903.785291808978;7353.926460735324;7630.8855367169535;7631.809204769926;7661.272179142972;7671.923280767232;6051.546134039964;6403.943349347305;7137.10786151731;7506.924930750732;7563.789793632992;7547.547147171077;7637.045369328834;7664.73173438927;7665.122045098987;7678.884816727754;5790;7168;7197.856042879009;7198.20819709842;7260.2739726026975;5485.780568777204;7161.4628902831455;7182.389496892613;7197.532160409557;7204.24355442671;7637;7698.615069246627;7700.614969251627;7726.459147859596;7745.883811742941;4574.062317224894;4601.263797792337;4617.0996655651825;4627.490975992706;4632.629389648888;7000.61496617691;7147.106611673541;7329.926700733137;7352.558846469229;7365.042544469185;7123.109611298588;7132.572045677069;7145.963835243964;7151.2133665297815;7154.821129471805;7159.105111861018;7166.713331466892;7169.139703235645;7170.282971702788;7192.604406757679;6948.583085014915;6986.6855991481525;6993.985872048626;6995.825104372431;7001.264867188872;6901.9302008188815;7088.503804733826;7128.6792094356915;7159.105111861018;7170.533915295489;6883.827904302432;6946.6179360135675;6974.267701891228;7000.124984376953;7021.1574611047 04:57:27 INFO - PROCESS | 1695 | |5;yui.html;682.1984168601892;717.8348979734658;720.1861896057454;730.5653136383853;751.4026349052502;14586.78119828202;14763.188024658639;14787.40850365984;14834.332455039508;14860.40558377665;15586.84413155871;15824.287907044181;15840;15849.683006339867;15876.682466350667;889.0176355127588;891.6656253904786;897.5960817632059;901.9188273055423;904.2901322461869;714.0146597695174;866.7789713623017;867.0852250875324;885.5041176940902;902.1249388093539;925.5696101312889;942.5381563034098;953.6185525789671;954.5990683912773;955.1451450951395;911;932.3799673217302;946.4605175050224;947.0766003146946;953.0183910572122;680.0513283968885;683.3747121383977;704.105785652224;704.1655638068904;706.2019917493251;15294.694106117926;15379.769303460456;15392.692146157126;15403.306851191723;15405.306761195772;12299.446524906401;12406.503739850396;12422.689432764162;12563.623091307276;12591.055670824724;7335.413166946685;8626.094260102724;8634.568271586395;8732.388732788708;8756.912430875673;3430.1767575781882;3476.461148521983;3478.147853775841;3479.304139172176;3481.216726236602;59987.400125999055;76077.61961190158;79109.41781164402;80807.59596201981;81036.78444823332;9100.362974591848;9171.724848254564;9197.678081267257;9354.953225233967;9452.669156579625;20408.89795551013;20616.38150855477;21165.04757285895;21211.68182477264;21221.68167477489;7370.299821516947;7375.8156046099275;7380.151282602569;7391.6304184791625;7645.847083058307;3804.6113168693782;4019.457373254632;4081.8571350002608;4123.484564429446;4132.33882578792;3262.60848698153;3478.3912815257227;3485.2680937003006;3560.91097722559;3579.997600671816;597.9562391229989;607.4229481992037;614.7264467312003;626.9185005949197;627.3569591169088;504.37709428855334;524.1168630857018;595.487880422836;596.3231731984142;604.909263610462;7659.195784442665;7841.568713720686;7953.443258971932;8107.635156417975;8140.104588495261;527.9947200528022;568.8492549474392;600.2586805295457;606.7694276175025;628.4940622798691;3732.869349572752;3743.513343265358;3813.809309534512;3842.6733727633464;3880.359740642819;76740;81934;82556.58721706473;83404.58297708472;89969;49445;75036;77227.61386193032;77782.05544861424;77872.61063694645;67914;68193.65903170552;68635.65682171557;68836.6558167216;69691;6634.706232284658;7195.784126476214;7686.57723825195;7730.7680769577;7811.960940195263;48811.511884880696;49606.759831004514;50206.748966254934;51169;51498.48501514937;62777.74444510993;66213;67086;67494.66252668705;68050;9788;9795.559199835881;9977.20182385393;10040.598376065167;10457.372557646566;10561.947190264;10669.94665026701;10739.516721747385;10741.89258107409;11031.558737650405;10188.847167292348;10206.13247873939;10316.793664126826;10630.468476576294;10913.781724365626;10230.693079207636;10319.690409287734;10573.841392378967;10720.571177152826;11140.164487663296;9947.751306217402;10029.197664186702;10072.899271007196;10317.432541210306;10382.3251488653;8233.135520770233;8255.917440825515;8459.703910363354;8544.957275213585;8547.059823419295;7295.744648937474;8102.513849169069;8434.283085937765;8467.957660211907;8792 04:57:27 INFO - PROCESS | 1695 | __end_tp_report 04:57:27 INFO - PROCESS | 1695 | __start_cc_report 04:57:27 INFO - PROCESS | 1695 | _x_x_mozilla_cycle_collect,368 04:57:27 INFO - PROCESS | 1695 | __end_cc_report 04:57:27 INFO - PROCESS | 1695 | __startTimestamp1460030247482__endTimestamp 04:57:27 INFO - PROCESS | 1695 | 04:57:27 INFO - PROCESS | 1695 | ------- Summary: start ------- 04:57:27 INFO - PROCESS | 1695 | Number of tests: 6 04:57:27 INFO - PROCESS | 1695 | 04:57:27 INFO - PROCESS | 1695 | [#0] dojo.html Cycles:165 Average:5719.66 Median:5971.88 stddev:664.14 (11.1%) stddev-sans-first:643.05 04:57:27 INFO - PROCESS | 1695 | Values: 3504.9 3541.4 3597.3 3608.9 3613.2 5660.8 5701.3 5754.9 5759.3 5777.5 4718.7 5710.0 5774.2 5864.6 5871.8 4258.9 5143.7 5168.0 5225.2 5277.3 4558.6 4567.5 4980.6 5295.1 5349.8 5101.5 5130.9 5180.6 5202.3 5275.7 5179.2 5186.3 5196.6 5210.4 5248.8 5162.6 5170.7 5179.7 5191.1 5244.0 5556.0 5653.3 5658.4 5708.2 5716.8 6154.0 6189.3 6214.0 6223.3 6244.5 6177.0 6235.5 6244.0 6247.9 6313.3 4676.0 5742.0 5851.4 5859.5 5959.0 6223.6 6288.7 6292.6 6305.7 6323.8 4582.5 6156.4 6175.4 6184.5 6220.3 6133.6 6176.8 6216.7 6276.1 6279.5 6052.9 6119.3 6172.2 6212.1 6216.4 6185.6 6226.7 6245.8 6250.5 6256.5 4838.2 4901.0 4924.0 4931.7 4987.7 4407.3 4414.1 4421.3 4425.9 4431.2 5650.9 5772.9 5779.9 5791.0 5847.2 5444.4 6290.6 6312.4 6319.2 6321.6 4847.0 5675.2 5730.7 5797.4 5802.6 5338.5 5396.0 5439.6 5446.7 5447.3 6331.1 6375.0 6382.2 6392.8 6486.3 5203.4 6205.9 6320.1 6321.9 6350.2 6193.8 6301.7 6337.4 6355.3 6395.7 6185.9 6232.8 6252.6 6273.5 6281.7 6140.2 6237.8 6295.9 6323.4 6348.8 5983.3 6017.0 6085.1 6105.7 6197.4 5992.2 6028.5 6110.2 6125.4 6129.5 5883.6 5946.7 5957.6 5971.9 6096.4 6083.1 6114.7 6135.5 6148.9 6189.3 5953.3 6046.6 6051.1 6077.5 6112.3 04:57:27 INFO - PROCESS | 1695 | 04:57:27 INFO - PROCESS | 1695 | [#1] ext.html Cycles:180 Average:62967.23 Median:37600.84 stddev:128677.83 (342.2%) stddev-sans-first:128953.25 04:57:27 INFO - PROCESS | 1695 | Values: 472.5 561.9 571.9 576.9 623.2 33549.8 37524.0 37574.9 37626.8 37819.8 39439.0 40192.2 40779.0 40828.6 40925.8 9403.7 9454.8 9535.2 9662.2 9691.8 8161.2 9471.2 9526.3 9661.2 9679.5 9548.1 9573.4 9684.2 9693.3 9706.1 9590.0 9597.4 9617.6 9693.4 9693.8 9466.8 9510.4 9559.9 9582.0 9619.7 37146.7 37160.8 37220.6 37538.2 37859.0 2949.6 3064.4 3161.0 3163.8 3311.2 27038.9 27260.6 27922.9 27973.2 28070.0 2683.4 2696.1 2723.2 2839.7 2906.1 435969.0 461829.2 489287.0 493000.0 495618.0 66811.0 67289.0 67310.0 67316.7 67327.7 68081.7 69395.0 70964.0 71659.9 72810.8 11839.9 16090.0 16152.4 16334.0 16398.1 9771.0 12229.9 12300.4 12722.9 12807.3 20062.0 20488.2 20543.7 20741.5 20742.9 7429.0 8152.8 8557.0 8762.5 9054.6 785.0 994.9 1021.2 1053.9 1114.4 25133.0 28780.1 28893.4 29699.9 29901.3 1052.2 1088.9 1113.8 1120.4 1149.9 13002.7 13408.8 14577.0 14888.1 14985.8 504455.0 507328.0 509246.0 511041.0 511338.0 55916.0 56110.0 56210.4 56718.0 56961.0 1428.2 1467.7 1470.1 1472.1 1481.4 28377.0 28453.6 28971.4 29469.9 29505.0 48886.8 48936.3 49023.3 49068.3 49446.5 465283.0 465475.0 467004.0 467789.0 470183.0 31561.2 32976.3 33041.3 33531.3 33590.8 41965.6 44270.0 44411.8 45062.8 45350.3 35797.8 37143.4 37420.0 37725.6 37818.6 35939.0 36047.8 36212.3 37011.3 37053.3 30837.4 36847.4 36988.4 37491.6 38399.8 32064.7 33309.7 33599.7 33659.5 33718.0 24287.4 24310.6 24379.3 24986.1 25023.9 04:57:27 INFO - PROCESS | 1695 | 04:57:27 INFO - PROCESS | 1695 | [#2] jquery.html Cycles:180 Average:32202.83 Median:20906.03 stddev:94006.93 (449.7%) stddev-sans-first:94240.22 04:57:27 INFO - PROCESS | 1695 | Values: 348.0 358.3 358.9 362.0 363.7 19556.4 19717.9 20742.6 20974.8 21272.1 16805.8 19706.3 20095.7 20837.3 21049.7 4854.0 5024.9 5158.4 5267.4 5339.9 3898.8 5250.3 5652.0 5895.2 5897.5 5769.1 5784.6 5852.1 5901.4 5909.1 5815.1 6376.7 6547.3 6569.8 6572.0 5565.6 5586.4 5678.0 5727.2 5729.1 13304.7 13584.5 13626.7 13649.3 14171.2 1910.4 2033.0 2159.3 2300.5 2467.5 8393.6 9375.4 9478.3 10030.0 10043.4 1650.7 1749.4 1759.2 1760.4 1762.6 95059.0 101712.0 102098.0 103458.0 104800.0 10931.2 10934.5 10992.8 11048.2 11049.3 13120.5 13181.3 13194.9 13389.9 13563.9 6463.9 6471.4 7844.5 8379.9 8455.2 8315.6 8485.9 8573.1 8626.7 8649.4 3669.4 4327.3 4340.3 4370.3 4433.9 1723.9 1723.9 1806.6 1812.7 1840.4 935.2 970.1 993.8 1023.2 1064.7 16176.8 19400.1 19737.8 19917.0 20033.0 975.5 982.7 992.9 1049.1 1064.0 10403.7 11001.3 11004.1 11072.4 11120.1 556862.0 562893.0 562914.0 573542.0 575435.0 108481.0 109212.5 110037.4 112625.4 114427.0 1013.4 1035.3 1041.1 1043.2 1057.9 15762.4 17891.9 17938.6 18217.8 18479.9 47468.5 47512.5 48528.5 48662.3 48772.0 68220.7 68796.7 69131.0 69207.0 69605.0 7710.8 7832.1 7904.0 7986.1 8167.5 9240.3 11228.6 12100.3 12611.2 12744.3 10846.8 10850.7 10954.7 10984.0 11038.4 8727.9 10875.3 10953.4 11188.7 11236.2 10686.1 10995.3 11088.9 11257.2 11284.4 7803.1 7814.7 7816.7 7838.0 7871.9 9292.2 10732.4 10888.9 10899.2 11097.8 04:57:27 INFO - PROCESS | 1695 | 04:57:27 INFO - PROCESS | 1695 | [#3] mootools.html Cycles:180 Average:5976.84 Median:5376.10 stddev:3106.18 (57.8%) stddev-sans-first:3097.26 04:57:27 INFO - PROCESS | 1695 | Values: 1572.9 1598.1 1868.3 1962.5 1983.4 7856.3 8566.1 8593.4 8786.5 8805.9 8558.0 8601.2 8674.5 8680.4 8701.5 2442.1 2445.2 2451.8 2454.3 2491.0 2377.2 2443.0 2473.4 2506.2 2511.6 2462.3 2470.0 2476.1 2501.3 2517.2 2448.8 2457.3 2467.8 2469.2 2497.9 2420.3 2465.4 2491.8 2492.4 2506.7 8761.7 8794.0 8824.5 8831.2 8842.9 5364.0 5372.2 5380.0 5409.6 5499.9 3547.8 3635.4 3639.6 3650.3 3724.1 1015.4 1041.2 1050.9 1052.1 1058.3 10727.7 11103.2 11576.3 11929.8 11938.6 4800.6 4875.6 4944.6 4963.4 4988.6 8376.6 10042.4 10109.1 10122.0 10138.1 5431.4 5450.9 5456.3 5510.1 5512.0 4508.7 4869.4 4916.2 4974.4 5000.7 3904.5 3963.8 4022.3 4033.2 4106.4 1307.4 1308.8 1317.8 1326.7 1353.5 1371.0 1374.8 1375.9 1395.4 1409.4 8256.6 8315.7 8321.0 8336.4 8368.6 503.1 505.0 511.2 512.1 512.7 6204.9 6243.9 6279.9 6280.5 6284.8 8883.5 10190.1 10455.3 10458.1 10484.3 10341.0 10344.4 10397.1 10441.2 10449.4 7823.6 7992.3 8012.0 8063.4 8243.5 7960.4 7997.0 8047.0 8126.6 8128.4 9140.4 9251.2 9391.3 9506.2 9619.5 9337.0 9780.6 9838.3 9987.1 10008.7 5887.0 7006.7 7198.0 7556.1 7638.8 6810.1 7422.4 7587.6 8103.9 8225.5 6643.3 7310.8 7344.5 7419.4 7530.7 7256.2 7257.8 7264.7 7345.0 7458.7 7039.9 7724.4 7755.2 7759.1 7767.6 7004.1 7005.6 7041.1 7049.6 7051.7 6962.3 7026.6 7109.2 7117.3 7133.2 04:57:27 INFO - PROCESS | 1695 | 04:57:27 INFO - PROCESS | 1695 | [#4] prototype.html Cycles:180 Average:5687.42 Median:6428.79 stddev:1852.38 (28.8%) stddev-sans-first:1812.94 04:57:27 INFO - PROCESS | 1695 | Values: 301.9 323.2 326.3 330.6 331.2 5243.8 6518.4 6565.0 6620.7 6642.7 5228.9 6495.3 6558.4 6591.3 6618.7 4587.1 4662.5 4856.1 4865.9 4876.5 4835.8 4854.2 4855.2 4865.0 4868.9 4791.7 4792.1 4800.6 4818.1 4829.4 4815.4 4817.4 4819.4 4830.2 4842.8 4144.3 4172.5 4174.6 4175.2 4184.5 4994.0 5329.8 5951.8 6278.8 6312.7 5363.2 5577.5 5578.0 5600.0 5609.5 6947.9 6986.2 6989.3 6989.6 7006.7 3687.4 4526.7 4541.2 4551.2 4562.7 6239.3 7072.1 7324.9 7393.8 7436.7 4345.5 4488.6 4504.1 4572.4 4581.7 4658.7 4695.4 4699.6 4702.6 4718.9 4486.0 5546.4 5546.8 5557.3 5605.7 6985.9 6989.6 7023.3 7027.0 7041.3 1267.9 1299.1 1409.9 1605.3 1642.9 1000.9 1008.6 1049.3 1050.9 1055.1 5514.4 5859.9 5899.0 6506.2 6516.0 7310.7 7341.4 7348.9 7353.4 7368.6 6418.9 6438.7 6450.6 6481.1 6503.3 3839.1 3869.5 3892.7 3894.8 3903.8 7353.9 7630.9 7631.8 7661.3 7671.9 6051.5 6403.9 7137.1 7506.9 7563.8 7547.5 7637.0 7664.7 7665.1 7678.9 5790.0 7168.0 7197.9 7198.2 7260.3 5485.8 7161.5 7182.4 7197.5 7204.2 7637.0 7698.6 7700.6 7726.5 7745.9 4574.1 4601.3 4617.1 4627.5 4632.6 7000.6 7147.1 7329.9 7352.6 7365.0 7123.1 7132.6 7146.0 7151.2 7154.8 7159.1 7166.7 7169.1 7170.3 7192.6 6948.6 6986.7 6994.0 6995.8 7001.3 6901.9 7088.5 7128.7 7159.1 7170.5 6883.8 6946.6 6974.3 7000.1 7021.2 04:57:27 INFO - PROCESS | 1695 | 04:57:27 INFO - PROCESS | 1695 | [#5] yui.html Cycles:180 Average:17360.67 Median:36860.35 stddev:24238.33 (65.8%) stddev-sans-first:24273.97 04:57:27 INFO - PROCESS | 1695 | Values: 682.2 717.8 720.2 730.6 751.4 14586.8 14763.2 14787.4 14834.3 14860.4 15586.8 15824.3 15840.0 15849.7 15876.7 889.0 891.7 897.6 901.9 904.3 714.0 866.8 867.1 885.5 902.1 925.6 942.5 953.6 954.6 955.1 911.0 932.4 946.5 947.1 953.0 680.1 683.4 704.1 704.2 706.2 15294.7 15379.8 15392.7 15403.3 15405.3 12299.4 12406.5 12422.7 12563.6 12591.1 7335.4 8626.1 8634.6 8732.4 8756.9 3430.2 3476.5 3478.1 3479.3 3481.2 59987.4 76077.6 79109.4 80807.6 81036.8 9100.4 9171.7 9197.7 9355.0 9452.7 20408.9 20616.4 21165.0 21211.7 21221.7 7370.3 7375.8 7380.2 7391.6 7645.8 3804.6 4019.5 4081.9 4123.5 4132.3 3262.6 3478.4 3485.3 3560.9 3580.0 598.0 607.4 614.7 626.9 627.4 504.4 524.1 595.5 596.3 604.9 7659.2 7841.6 7953.4 8107.6 8140.1 528.0 568.8 600.3 606.8 628.5 3732.9 3743.5 3813.8 3842.7 3880.4 76740.0 81934.0 82556.6 83404.6 89969.0 49445.0 75036.0 77227.6 77782.1 77872.6 67914.0 68193.7 68635.7 68836.7 69691.0 6634.7 7195.8 7686.6 7730.8 7812.0 48811.5 49606.8 50206.7 51169.0 51498.5 62777.7 66213.0 67086.0 67494.7 68050.0 9788.0 9795.6 9977.2 10040.6 10457.4 10561.9 10669.9 10739.5 10741.9 11031.6 10188.8 10206.1 10316.8 10630.5 10913.8 10230.7 10319.7 10573.8 10720.6 11140.2 9947.8 10029.2 10072.9 10317.4 10382.3 8233.1 8255.9 8459.7 8545.0 8547.1 7295.7 8102.5 8434.3 8468.0 8792.0 04:57:27 INFO - PROCESS | 1695 | -------- Summary: end -------- 04:57:27 INFO - PROCESS | 1695 | 04:57:27 INFO - TEST-INFO | 1695: exit 0 04:57:27 INFO - TEST-OK | dromaeo_css | took 1111600ms 04:57:27 INFO - TEST-START | kraken 04:57:27 INFO - operating with platform_type : mac_ 04:57:27 INFO - Initialising browser for kraken test... 04:57:27 INFO - TEST-INFO | started process 1702 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmprAjwMt/profile http://localhost:49265/getInfo.html) 04:57:30 INFO - PROCESS | 1702 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 04:57:30 INFO - PROCESS | 1702 | __metrics Screen width/height:1600/1200 04:57:30 INFO - PROCESS | 1702 | colorDepth:24 04:57:30 INFO - PROCESS | 1702 | Browser inner width/height: 1024/689 04:57:30 INFO - PROCESS | 1702 | __metrics 04:57:30 ERROR - PROCESS | 1702 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 04:57:31 INFO - TEST-INFO | 1702: exit 0 04:57:31 INFO - Browser initialized. 04:57:31 INFO - Running cycle 1/1 for kraken test... 04:57:31 INFO - TEST-INFO | started process 1705 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmprAjwMt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:57:43 INFO - PROCESS | 1705 | RSS: Main: 246775808 04:57:43 INFO - PROCESS | 1705 | 04:57:45 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection) 04:57:46 INFO - PROCESS | 1705 | RSS: Main: 259067904 04:57:46 INFO - PROCESS | 1705 | 04:57:48 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-dft) 04:57:49 INFO - PROCESS | 1705 | RSS: Main: 268492800 04:57:49 INFO - PROCESS | 1705 | 04:57:52 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-fft) 04:57:53 INFO - PROCESS | 1705 | RSS: Main: 271630336 04:57:53 INFO - PROCESS | 1705 | 04:57:55 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator) 04:57:56 INFO - PROCESS | 1705 | RSS: Main: 273584128 04:57:56 INFO - PROCESS | 1705 | 04:57:58 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:57:59 INFO - PROCESS | 1705 | RSS: Main: 274087936 04:57:59 INFO - PROCESS | 1705 | 04:58:01 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom) 04:58:02 INFO - PROCESS | 1705 | RSS: Main: 274395136 04:58:02 INFO - PROCESS | 1705 | 04:58:05 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate) 04:58:05 INFO - PROCESS | 1705 | RSS: Main: 274120704 04:58:05 INFO - PROCESS | 1705 | 04:58:08 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial) 04:58:09 INFO - PROCESS | 1705 | RSS: Main: 274436096 04:58:09 INFO - PROCESS | 1705 | 04:58:10 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:58:11 INFO - PROCESS | 1705 | RSS: Main: 274255872 04:58:11 INFO - PROCESS | 1705 | 04:58:13 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:58:14 INFO - PROCESS | 1705 | RSS: Main: 274182144 04:58:14 INFO - PROCESS | 1705 | 04:58:16 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:58:16 INFO - PROCESS | 1705 | RSS: Main: 274243584 04:58:16 INFO - PROCESS | 1705 | 04:58:19 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:58:20 INFO - PROCESS | 1705 | RSS: Main: 274505728 04:58:20 INFO - PROCESS | 1705 | 04:58:22 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:58:23 INFO - PROCESS | 1705 | RSS: Main: 274366464 04:58:23 INFO - PROCESS | 1705 | 04:58:25 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49265/tests/kraken/driver.html?testName=ai-astar) 04:58:25 INFO - PROCESS | 1705 | RSS: Main: 276410368 04:58:25 INFO - PROCESS | 1705 | 04:58:25 INFO - PROCESS | 1705 | __start_tp_report 04:58:25 INFO - PROCESS | 1705 | _x_x_mozilla_page_load 04:58:25 INFO - PROCESS | 1705 | _x_x_mozilla_page_load_details 04:58:25 INFO - PROCESS | 1705 | |i|pagename|runs| 04:58:25 INFO - PROCESS | 1705 | |0;ai-astar;115;108;116;113;114;128;113;114;115;113 04:58:25 INFO - PROCESS | 1705 | |1;audio-beat-detection;148;122;144;158;121;142;141;124;184;145 04:58:25 INFO - PROCESS | 1705 | |2;audio-dft;194;196;200;202;211;238;195;196;204;200 04:58:25 INFO - PROCESS | 1705 | |3;audio-fft;74;71;58;85;81;87;96;143;56;56 04:58:25 INFO - PROCESS | 1705 | |4;audio-oscillator;90;80;118;78;79;83;119;83;79;120 04:58:25 INFO - PROCESS | 1705 | |5;imaging-gaussian-blur;92;89;91;90;93;88;93;90;92;88 04:58:25 INFO - PROCESS | 1705 | |6;imaging-darkroom;96;98;96;97;97;97;97;106;97;133 04:58:25 INFO - PROCESS | 1705 | |7;imaging-desaturate;89;91;99;90;92;92;91;92;92;90 04:58:25 INFO - PROCESS | 1705 | |8;json-parse-financial;58;58;56;60;64;77;88;95;57;53 04:58:25 INFO - PROCESS | 1705 | |9;json-stringify-tinderbox;67;66;81;64;84;90;105;58;87;104 04:58:25 INFO - PROCESS | 1705 | |10;stanford-crypto-aes;88;87;82;84;88;91;114;77;102;111 04:58:25 INFO - PROCESS | 1705 | |11;stanford-crypto-ccm;129;138;124;136;137;143;144;152;143;125 04:58:25 INFO - PROCESS | 1705 | |12;stanford-crypto-pbkdf2;161;188;187;143;139;130;142;141;139;155 04:58:25 INFO - PROCESS | 1705 | |13;stanford-crypto-sha256-iterative;69;68;63;69;70;70;69;69;68;72 04:58:25 INFO - PROCESS | 1705 | __end_tp_report 04:58:25 INFO - PROCESS | 1705 | __start_cc_report 04:58:25 INFO - PROCESS | 1705 | _x_x_mozilla_cycle_collect,1006 04:58:25 INFO - PROCESS | 1705 | __end_cc_report 04:58:25 INFO - PROCESS | 1705 | __startTimestamp1460030305442__endTimestamp 04:58:25 INFO - PROCESS | 1705 | 04:58:25 INFO - PROCESS | 1705 | ------- Summary: start ------- 04:58:25 INFO - PROCESS | 1705 | Number of tests: 14 04:58:25 INFO - PROCESS | 1705 | 04:58:25 INFO - PROCESS | 1705 | [#0] ai-astar Cycles:10 Average:114.90 Median:114.50 stddev:5.09 (4.4%) stddev-sans-first:5.40 04:58:25 INFO - PROCESS | 1705 | Values: 115.0 108.0 116.0 113.0 114.0 128.0 113.0 114.0 115.0 113.0 04:58:25 INFO - PROCESS | 1705 | 04:58:25 INFO - PROCESS | 1705 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:144.50 stddev:18.94 (13.1%) stddev-sans-first:19.99 04:58:25 INFO - PROCESS | 1705 | Values: 148.0 122.0 144.0 158.0 121.0 142.0 141.0 124.0 184.0 145.0 04:58:25 INFO - PROCESS | 1705 | 04:58:25 INFO - PROCESS | 1705 | [#2] audio-dft Cycles:10 Average:203.60 Median:201.00 stddev:13.12 (6.5%) stddev-sans-first:13.44 04:58:25 INFO - PROCESS | 1705 | Values: 194.0 196.0 200.0 202.0 211.0 238.0 195.0 196.0 204.0 200.0 04:58:25 INFO - PROCESS | 1705 | 04:58:25 INFO - PROCESS | 1705 | [#3] audio-fft Cycles:10 Average:80.70 Median:77.50 stddev:25.92 (33.4%) stddev-sans-first:27.38 04:58:25 INFO - PROCESS | 1705 | Values: 74.0 71.0 58.0 85.0 81.0 87.0 96.0 143.0 56.0 56.0 04:58:25 INFO - PROCESS | 1705 | 04:58:25 INFO - PROCESS | 1705 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:79.50 stddev:18.33 (23.1%) stddev-sans-first:19.42 04:58:25 INFO - PROCESS | 1705 | Values: 90.0 80.0 118.0 78.0 79.0 83.0 119.0 83.0 79.0 120.0 04:58:25 INFO - PROCESS | 1705 | 04:58:25 INFO - PROCESS | 1705 | [#5] imaging-gaussian-blur Cycles:10 Average:90.60 Median:91.50 stddev:1.90 (2.1%) stddev-sans-first:1.94 04:58:25 INFO - PROCESS | 1705 | Values: 92.0 89.0 91.0 90.0 93.0 88.0 93.0 90.0 92.0 88.0 04:58:25 INFO - PROCESS | 1705 | 04:58:25 INFO - PROCESS | 1705 | [#6] imaging-darkroom Cycles:10 Average:101.40 Median:97.00 stddev:11.48 (11.8%) stddev-sans-first:12.01 04:58:25 INFO - PROCESS | 1705 | Values: 96.0 98.0 96.0 97.0 97.0 97.0 97.0 106.0 97.0 133.0 04:58:25 INFO - PROCESS | 1705 | 04:58:25 INFO - PROCESS | 1705 | [#7] imaging-desaturate Cycles:10 Average:91.80 Median:92.00 stddev:2.74 (3.0%) stddev-sans-first:2.71 04:58:25 INFO - PROCESS | 1705 | Values: 89.0 91.0 99.0 90.0 92.0 92.0 91.0 92.0 92.0 90.0 04:58:25 INFO - PROCESS | 1705 | 04:58:25 INFO - PROCESS | 1705 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:62.00 stddev:14.76 (23.8%) stddev-sans-first:15.32 04:58:25 INFO - PROCESS | 1705 | Values: 58.0 58.0 56.0 60.0 64.0 77.0 88.0 95.0 57.0 53.0 04:58:25 INFO - PROCESS | 1705 | 04:58:25 INFO - PROCESS | 1705 | [#9] json-stringify-tinderbox Cycles:10 Average:80.60 Median:74.00 stddev:16.56 (22.4%) stddev-sans-first:16.82 04:58:25 INFO - PROCESS | 1705 | Values: 67.0 66.0 81.0 64.0 84.0 90.0 105.0 58.0 87.0 104.0 04:58:25 INFO - PROCESS | 1705 | 04:58:25 INFO - PROCESS | 1705 | [#10] stanford-crypto-aes Cycles:10 Average:92.40 Median:85.50 stddev:12.43 (14.5%) stddev-sans-first:13.08 04:58:25 INFO - PROCESS | 1705 | Values: 88.0 87.0 82.0 84.0 88.0 91.0 114.0 77.0 102.0 111.0 04:58:25 INFO - PROCESS | 1705 | 04:58:25 INFO - PROCESS | 1705 | [#11] stanford-crypto-ccm Cycles:10 Average:137.10 Median:140.50 stddev:8.97 (6.4%) stddev-sans-first:9.03 04:58:25 INFO - PROCESS | 1705 | Values: 129.0 138.0 124.0 136.0 137.0 143.0 144.0 152.0 143.0 125.0 04:58:25 INFO - PROCESS | 1705 | 04:58:25 INFO - PROCESS | 1705 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.50 Median:149.00 stddev:20.36 (13.7%) stddev-sans-first:21.37 04:58:25 INFO - PROCESS | 1705 | Values: 161.0 188.0 187.0 143.0 139.0 130.0 142.0 141.0 139.0 155.0 04:58:25 INFO - PROCESS | 1705 | 04:58:25 INFO - PROCESS | 1705 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:2.31 (3.4%) stddev-sans-first:2.45 04:58:25 INFO - PROCESS | 1705 | Values: 69.0 68.0 63.0 69.0 70.0 70.0 69.0 69.0 68.0 72.0 04:58:25 INFO - PROCESS | 1705 | -------- Summary: end -------- 04:58:25 INFO - PROCESS | 1705 | 04:58:25 INFO - TEST-INFO | 1705: exit 0 04:58:26 INFO - TEST-OK | kraken | took 58131ms 04:58:26 INFO - SUITE-END | took 1169s 04:58:26 INFO - Completed test suite (00:19:29) 04:58:26 INFO - javascript benchmark 04:58:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3504.8773292934743, 3541.3625547401457, 3597.3165098631275, 3608.9278214435712, 3613.1689711366384, 5660.801871934483, 5701.315842098944, 5754.942450575493, 5759.337676167237, 5777.45114214149, 4718.725943995119, 5710.000749868777, 5774.191613174148, 5864.648121112737, 5871.765129394819, 4258.871399079247, 5143.717095559743, 5168.0, 5225.216217567377, 5277.287566178555, 4558.566936141078, 4567.451905771312, 4980.576650984671, 5295.0733621616255, 5349.759260833272, 5101.464346243665, 5130.897382052375, 5180.611454140954, 5202.323697919246, 5275.683458992454, 5179.171332586768, 5186.325777648919, 5196.558292545138, 5210.426853046162, 5248.790048398059, 5162.638615296931, 5170.741462926839, 5179.689218646893, 5191.0656081905245, 5243.973780131075, 5555.972220138914, 5653.293338332708, 5658.377578466366, 5708.200851880699, 5716.828495145152, 6154.0, 6189.257289125334, 6214.042576588406, 6223.315435302113, 6244.531660125509, 6177.0, 6235.501159907197, 6244.0009598464485, 6247.937520624781, 6313.273973493061, 4675.95324046762, 5741.971290143522, 5851.4148585141575, 5859.53123750099, 5959.046552551571, 6223.626582405071, 6288.748450062038, 6292.590981586182, 6305.747770089145, 6323.841903952346, 4582.518835522222, 6156.445919867144, 6175.3824617538785, 6184.536159788034, 6220.284667263232, 6133.6319820810895, 6176.7838125665385, 6216.658083805343, 6276.058591211264, 6279.497640188774, 6052.939470605325, 6119.25883887406, 6172.22847144107, 6212.099245609361, 6216.378362163838, 6185.597936134137, 6226.6575338355915, 6245.78207249582, 6250.531210159256, 6256.499480041586, 4838.153323168502, 4900.950990490121, 4924.03981223658, 4931.679440836334, 4987.725675087905, 4407.338899165086, 4414.09511050234, 4421.292593185075, 4425.933610995838, 4431.224535706238, 5650.943490565124, 5772.913406298909, 5779.942200577941, 5791.0, 5847.181394604759, 5444.428335024844, 6290.591111577733, 6312.400321969406, 6319.241690997018, 6321.589096708699, 4846.975765121152, 5675.177099320658, 5730.74211660468, 5797.420257974169, 5802.564807639444, 5338.519533241949, 5396.0, 5439.5920305976415, 5446.700431476307, 5447.319085114361, 6331.113644089831, 6374.968125159345, 6382.170317858741, 6392.776252831129, 6486.286508484157, 5203.427622961547, 6205.906911396242, 6320.083587879823, 6321.862064828375, 6350.237971443272, 6193.81418557444, 6301.747930082745, 6337.366263373626, 6355.30091689923, 6395.744170233139, 6185.907211391743, 6232.844178895564, 6252.5935814171935, 6273.498120150468, 6281.685915704288, 6140.232470941132, 6237.844053898689, 6295.874082518416, 6323.399277068671, 6348.841278968062, 5983.34183239852, 6017.0, 6085.1480792689945, 6105.732692890381, 6197.380261973766, 5992.191054207626, 6028.457438830526, 6110.194261626774, 6125.448709616156, 6129.509639228941, 5883.646761244852, 5946.732397042057, 5957.642541447527, 5971.880562388815, 6096.420840020369, 6083.061604606031, 6114.728311729558, 6135.508280839814, 6148.862460444832, 6189.257289125334, 5953.28560572734, 6046.637201767908, 6051.062085376773, 6077.4834139098675, 6112.2970858351855], "unit": "score", "name": "dojo.html", "value": 5680.558515264769}, {"lowerIsBetter": false, "replicates": [472.46611329198004, 561.9016672082382, 571.9142128680697, 576.8520643918603, 623.2365352443256, 33549.83225083874, 37524.0, 37574.87275381736, 37626.8118659407, 37819.81090094546, 39439.0, 40192.19615607686, 40779.0, 40828.59171408285, 40925.795371023174, 9403.670871519482, 9454.763630909214, 9535.189508891752, 9662.178714809215, 9691.806163876718, 8161.183881611821, 9471.194948429358, 9526.28552858535, 9661.227101831837, 9679.467629280387, 9548.140667339938, 9573.42559446432, 9684.225261979025, 9693.273004524654, 9706.126448619623, 9590.040995900425, 9597.376170548892, 9617.615295388176, 9693.3699309545, 9693.757656058584, 9466.810663786755, 9510.429374237568, 9559.856602150974, 9582.041795820362, 9619.663311784125, 37146.699865504575, 37160.81419592912, 37220.627793721986, 37538.249235015144, 37859.0, 2949.6165498485275, 3064.3718037802196, 3161.0, 3163.810171389701, 3311.1887587541205, 27038.864805676043, 27260.59109113365, 27922.860385697943, 27973.160805175674, 28070.017549385877, 2683.409649877024, 2696.1237597780605, 2723.237493501823, 2839.730225628562, 2906.084583356257, 435969.0, 461829.2176852016, 489287.0, 493000.0, 495618.0, 66810.99783503251, 67289.0, 67310.0, 67316.66341668359, 67327.66336168288, 68081.65959170173, 69395.0, 70964.0, 71659.92510112353, 72810.81567552983, 11839.88160118405, 16090.0, 16152.35390584387, 16334.0, 16398.09810460436, 9771.0, 12229.877701223051, 12300.446479908425, 12722.936385318015, 12807.295598741972, 20062.0, 20488.18047278092, 20543.691844622343, 20741.481462963548, 20742.89628551878, 7429.0, 8152.755417337489, 8556.957215214008, 8762.458886922848, 9054.637814487478, 785.0265670568454, 994.9303548751662, 1021.2493817044466, 1053.910417614496, 1114.4427786106946, 25133.0, 28780.136595902157, 28893.42213155725, 29699.85150074236, 29901.25246868802, 1052.2423854824515, 1088.9346639201674, 1113.8273567597034, 1120.3949867071854, 1149.9252548584316, 13002.699730026921, 13408.798868016987, 14577.0, 14888.106713597219, 14985.775213371808, 504455.0, 507328.0, 509246.0, 511041.0, 511338.0, 55916.0, 56110.0, 56210.43789562134, 56718.0, 56961.0, 1428.2073449235565, 1467.6771110355705, 1470.1105830972322, 1472.0873058703671, 1481.4000329866421, 28377.034019046172, 28453.573196402485, 28971.42057158887, 29469.852650736608, 29505.0, 48886.75556622194, 48936.26595600998, 49023.26465102955, 49068.26397603967, 49446.50553494563, 465283.0, 465475.0, 467004.0, 467789.0, 470183.0, 31561.210969725023, 32976.34047319088, 33041.33917321688, 33531.32937341288, 33590.832045840594, 41965.60343071297, 44270.0, 44411.77794111138, 45062.77468612767, 45350.319745204506, 35797.82101089478, 37143.44284835784, 37420.0, 37725.62274377221, 37818.62181378151, 35939.0, 36047.81976090103, 36212.27575448529, 37011.259774804894, 37053.25893482062, 30837.383252335276, 36847.44728829016, 36988.44517332188, 37491.62508374881, 38399.84800455879, 32064.717411303285, 33309.66690333065, 33599.664003359656, 33659.50282262019, 33718.0, 24287.392815179763, 24310.63534047026, 24379.26862194137, 24986.125485607918, 25023.87488062548], "unit": "score", "name": "ext.html", "value": 19553.374997500756}, {"lowerIsBetter": false, "replicates": [347.95650543682024, 358.34244161962806, 358.8582509908586, 361.95113659655937, 363.73447383410127, 19556.41330760078, 19717.901410492945, 20742.585148297025, 20974.790252097475, 21272.14911403546, 16805.83194168058, 19706.310279140234, 20095.698564521543, 20837.270695525658, 21049.684254736192, 4854.0, 5024.924626130611, 5158.380994280673, 5267.3942496613, 5339.866503337409, 3898.8245528951124, 5250.343707036621, 5652.0, 5895.174675545427, 5897.528197744192, 5769.105788602773, 5784.595078344518, 5852.063669812831, 5901.439363260483, 5909.113632955048, 5815.09147559319, 6376.7130479128555, 6547.345265473438, 6569.835754106138, 6572.047053177311, 5565.582581306418, 5586.413426590231, 5677.971610141964, 5727.198192253088, 5729.083346664555, 13304.667383315495, 13584.524541640994, 13626.659333516642, 13649.317534123255, 14171.220582867938, 1910.360029390156, 2032.9593408131755, 2159.3198142585034, 2300.5283916797016, 2467.546613064522, 8393.580320983987, 9375.390599611004, 9478.336516443851, 10030.0, 10043.397396156253, 1650.7276299410582, 1749.3877142999847, 1759.1995641982867, 1760.3838656470261, 1762.6122253104425, 95059.0, 101711.982880171, 102098.0, 103458.0, 104799.95200048054, 10931.234813563133, 10934.507947142398, 10992.780144397228, 11048.226624136234, 11049.337039777478, 13120.475180992653, 13181.340932953506, 13194.934025330003, 13389.928805695521, 13563.864361356458, 6463.870722585522, 6471.449926756184, 7844.4901081429525, 8379.916200837913, 8455.154484551618, 8315.58635032046, 8485.915140848636, 8573.056963733985, 8626.698065567674, 8649.437786543855, 3669.412893936957, 4327.307630779123, 4340.262155433584, 4370.344448332776, 4433.8669839904205, 1723.8793284469966, 1723.922423490921, 1806.5972256898294, 1812.7099664053687, 1840.401869392453, 935.2284365398573, 970.1317320997667, 993.7962717642865, 1023.2121266624806, 1064.7338165458636, 16176.75734863978, 19400.126994285292, 19737.802621973595, 19917.00414979274, 20033.0, 975.5414954971152, 982.6855406270068, 992.9404235745878, 1049.1030169205371, 1063.9893601064045, 10403.739906502247, 11001.284916480403, 11004.064654504456, 11072.444801364176, 11120.054795342325, 556862.0, 562893.0, 562914.0, 573542.0, 575435.0, 108481.0, 109212.45393773139, 110037.44981275042, 112625.43687281675, 114427.0, 1013.3717095400751, 1035.316690983947, 1041.1150522056344, 1043.2436483549366, 1057.8836328003913, 15762.448314308944, 17891.910540447214, 17938.5515362117, 18217.817821821613, 18479.891206527653, 47468.52531474779, 47512.4650431426, 48528.5147148524, 48662.27006594975, 48772.0, 68220.6588967052, 68796.6560167216, 69131.0, 69207.0, 69604.95592566217, 7710.7686769397005, 7832.138464768757, 7904.0, 7986.121526632182, 8167.469114507538, 9240.306976976619, 11228.606998755004, 12100.273983561014, 12611.243325400505, 12744.299063551594, 10846.783064338826, 10850.67447976562, 10954.671359859218, 10984.01143897053, 11038.44807759625, 8727.869081963903, 10875.347479151276, 10953.356996450277, 11188.72028199269, 11236.213465057368, 10686.145108391154, 10995.34027958325, 11088.889111108785, 11257.155713321697, 11284.379359135326, 7803.102643195878, 7814.726484573012, 7816.72641457569, 7837.960810195913, 7871.921280787119, 9292.16370526656, 10732.356058636507, 10888.891111088788, 10899.237053406185, 11097.833532496858], "unit": "score", "name": "jquery.html", "value": 9004.102578762531}, {"lowerIsBetter": false, "replicates": [1572.9134897580632, 1598.1449924290507, 1868.327402135231, 1962.5093726568357, 1983.3554094919145, 7856.332211761993, 8566.143385661439, 8593.398462107654, 8786.516741579211, 8805.911940880596, 8558.015828179761, 8601.18288762568, 8674.479531228131, 8680.435771674836, 8701.521416322099, 2442.1086303499274, 2445.156421034749, 2451.7915977141965, 2454.325060608338, 2490.991148584826, 2377.1679912030736, 2443.0, 2473.418746594549, 2506.1729629222405, 2511.573032584456, 2462.3105530451503, 2469.962950555743, 2476.071473197551, 2501.3371456564023, 2517.2070797698757, 2448.816338774599, 2457.336519139831, 2467.76556227159, 2469.2221950085664, 2497.900083996647, 2420.2739178246457, 2465.359006658282, 2491.7757401833924, 2492.401823562332, 2506.724260331362, 8761.737147885573, 8794.03265640779, 8824.470531768051, 8831.249343805785, 8842.867356989651, 5364.0, 5372.221027950925, 5379.9778042171865, 5409.6213265071465, 5499.917501237484, 3547.840347184357, 3635.381985062546, 3639.5632524097014, 3650.324689932371, 3724.087598538348, 1015.3907655406697, 1041.2138835179467, 1050.8738951325813, 1052.074174726236, 1058.3120971368594, 10727.678169654922, 11103.222774405795, 11576.305421674642, 11929.761404771943, 11938.582149624808, 4800.615950723934, 4875.585575226075, 4944.629152813553, 4963.404391472975, 4988.575971042429, 8376.581170941428, 10042.447665378475, 10109.090181883666, 10122.0, 10138.087572118397, 5431.402545719968, 5450.945490545044, 5456.317960254968, 5510.1459273812625, 5511.972440137773, 4508.729476231371, 4869.391326084239, 4916.213405855046, 4974.403071631427, 5000.724960127228, 3904.4533765272886, 3963.7621742694955, 4022.255882661717, 4033.153037862023, 4106.425100485934, 1307.3659275251496, 1308.8429388473253, 1317.7891537353978, 1326.7346530693708, 1353.477337994756, 1371.0128707330705, 1374.8212732344732, 1375.9449622015206, 1395.448797724893, 1409.401004573073, 8256.587170641564, 8315.667373305, 8321.043080045873, 8336.416450848503, 8368.58157092143, 503.0969409909222, 504.96717713348517, 511.16934980656436, 512.0552580488992, 512.6718899904064, 6204.875902481925, 6243.906341404882, 6279.937200628026, 6280.528960327993, 6284.842878928063, 8883.511406872554, 10190.133838623651, 10455.268131230892, 10458.111060559937, 10484.26610137283, 10341.0, 10344.37933723964, 10397.11624511925, 10441.164706823436, 10449.425281609432, 7823.647935842901, 7992.280694737386, 8011.959940200261, 8063.4355595108955, 8243.546604936666, 7960.363170946194, 7997.0, 8047.0, 8126.55303958288, 8128.431009829492, 9140.360174787702, 9251.213646839824, 9391.29565282593, 9506.191973682315, 9619.51902404863, 9337.0, 9780.559874805509, 9838.262130340396, 9987.101160895554, 10008.749781255527, 5887.0, 7006.719731210695, 7198.0, 7556.055493063367, 7638.847223055619, 6810.148731408574, 7422.369098626677, 7587.58268295249, 8103.87844182326, 8225.5475948821, 6643.30245324234, 7310.780676579711, 7344.522606030591, 7419.443541734499, 7530.736424225126, 7256.238094999949, 7257.802462593824, 7264.67308971087, 7345.045144131229, 7458.664360103699, 7039.8944015840825, 7724.382049436144, 7755.185705500841, 7759.146493885781, 7767.572783496962, 7004.124484439445, 7005.579665220103, 7041.084658994298, 7049.647517624201, 7051.682674279567, 6962.338577835098, 7026.613536255555, 7109.2179860216365, 7117.252688467844, 7133.179684336368], "unit": "score", "name": "mootools.html", "value": 4830.768927571176}, {"lowerIsBetter": false, "replicates": [301.93961207758446, 323.1904080278901, 326.26752939650487, 330.6329973729159, 331.21667256937343, 5243.842684719464, 6518.445932095771, 6565.0, 6620.668966551677, 6642.734290628375, 5228.895422091556, 6495.253045899723, 6558.409743123118, 6591.274959754423, 6618.735250589971, 4587.105514424688, 4662.463816661094, 4856.125897338477, 4865.905171336456, 4876.536729010738, 4835.815225269814, 4854.1990571555825, 4855.223164293714, 4864.975675121619, 4868.853934381957, 4791.664583479158, 4792.137415265251, 4800.615950723951, 4818.084563932859, 4829.396325459317, 4815.398075240595, 4817.373741413611, 4819.421669399677, 4830.227163653799, 4842.757862106916, 4144.33690609501, 4172.520160181588, 4174.624283814441, 4175.164967006581, 4184.51878034027, 4993.975030124862, 5329.8274379636805, 5951.791687290967, 6278.78024269153, 6312.684365781738, 5363.249145119687, 5577.498025177753, 5578.023845826964, 5599.972000140014, 5609.467100625434, 6947.861042779116, 6986.196587392464, 6989.266127056637, 6989.580625162455, 7006.684699188549, 3687.3547129252543, 4526.6831321807485, 4541.159885421208, 4551.2262915304145, 4562.657800664931, 6239.344868788758, 7072.115985501812, 7324.926750732478, 7393.778186654409, 7436.66535005926, 4345.543717909637, 4488.64090872736, 4504.09918016398, 4572.428446444194, 4581.725096494154, 4658.697184682985, 4695.43654761424, 4699.624030077585, 4702.576768090888, 4718.9292160617615, 4486.0, 5546.417626149277, 5546.833594992157, 5557.3331200256225, 5605.691686957257, 6985.860282794316, 6989.615571143636, 7023.262557431498, 7026.9648651756415, 7041.295870412918, 1267.8668739782374, 1299.0581828174686, 1409.943602255919, 1605.3257631794675, 1642.909639969813, 1000.884898236712, 1008.6318493749875, 1049.3284298049255, 1050.9159267258601, 1055.0504545908743, 5514.365847927459, 5859.886621541893, 5898.970505147447, 6506.219253689493, 6515.967420162963, 7310.671019804122, 7341.375983041395, 7348.926510734931, 7353.374963128087, 7368.594727289943, 6418.871622567616, 6438.7102580384, 6450.645214513247, 6481.09264702942, 6503.28463868974, 3839.0978120141745, 3869.4776205212497, 3892.746971446847, 3894.805259737002, 3903.785291808978, 7353.926460735324, 7630.8855367169535, 7631.809204769926, 7661.272179142972, 7671.923280767232, 6051.546134039964, 6403.943349347305, 7137.10786151731, 7506.924930750732, 7563.789793632992, 7547.547147171077, 7637.045369328834, 7664.73173438927, 7665.122045098987, 7678.884816727754, 5790.0, 7168.0, 7197.856042879009, 7198.20819709842, 7260.2739726026975, 5485.780568777204, 7161.4628902831455, 7182.389496892613, 7197.532160409557, 7204.24355442671, 7637.0, 7698.615069246627, 7700.614969251627, 7726.459147859596, 7745.883811742941, 4574.062317224894, 4601.263797792337, 4617.0996655651825, 4627.490975992706, 4632.629389648888, 7000.61496617691, 7147.106611673541, 7329.926700733137, 7352.558846469229, 7365.042544469185, 7123.109611298588, 7132.572045677069, 7145.963835243964, 7151.2133665297815, 7154.821129471805, 7159.105111861018, 7166.713331466892, 7169.139703235645, 7170.282971702788, 7192.604406757679, 6948.583085014915, 6986.6855991481525, 6993.985872048626, 6995.825104372431, 7001.264867188872, 6901.9302008188815, 7088.503804733826, 7128.6792094356915, 7159.105111861018, 7170.533915295489, 6883.827904302432, 6946.6179360135675, 6974.267701891228, 7000.124984376953, 7021.1574611047], "unit": "score", "name": "prototype.html", "value": 5062.981212834}, {"lowerIsBetter": false, "replicates": [682.1984168601892, 717.8348979734658, 720.1861896057454, 730.5653136383853, 751.4026349052502, 14586.78119828202, 14763.188024658639, 14787.40850365984, 14834.332455039508, 14860.40558377665, 15586.84413155871, 15824.287907044181, 15840.0, 15849.683006339867, 15876.682466350667, 889.0176355127588, 891.6656253904786, 897.5960817632059, 901.9188273055423, 904.2901322461869, 714.0146597695174, 866.7789713623017, 867.0852250875324, 885.5041176940902, 902.1249388093539, 925.5696101312889, 942.5381563034098, 953.6185525789671, 954.5990683912773, 955.1451450951395, 911.0, 932.3799673217302, 946.4605175050224, 947.0766003146946, 953.0183910572122, 680.0513283968885, 683.3747121383977, 704.105785652224, 704.1655638068904, 706.2019917493251, 15294.694106117926, 15379.769303460456, 15392.692146157126, 15403.306851191723, 15405.306761195772, 12299.446524906401, 12406.503739850396, 12422.689432764162, 12563.623091307276, 12591.055670824724, 7335.413166946685, 8626.094260102724, 8634.568271586395, 8732.388732788708, 8756.912430875673, 3430.1767575781882, 3476.461148521983, 3478.147853775841, 3479.304139172176, 3481.216726236602, 59987.400125999055, 76077.61961190158, 79109.41781164402, 80807.59596201981, 81036.78444823332, 9100.362974591848, 9171.724848254564, 9197.678081267257, 9354.953225233967, 9452.669156579625, 20408.89795551013, 20616.38150855477, 21165.04757285895, 21211.68182477264, 21221.68167477489, 7370.299821516947, 7375.8156046099275, 7380.151282602569, 7391.6304184791625, 7645.847083058307, 3804.6113168693782, 4019.457373254632, 4081.8571350002608, 4123.484564429446, 4132.33882578792, 3262.60848698153, 3478.3912815257227, 3485.2680937003006, 3560.91097722559, 3579.997600671816, 597.9562391229989, 607.4229481992037, 614.7264467312003, 626.9185005949197, 627.3569591169088, 504.37709428855334, 524.1168630857018, 595.487880422836, 596.3231731984142, 604.909263610462, 7659.195784442665, 7841.568713720686, 7953.443258971932, 8107.635156417975, 8140.104588495261, 527.9947200528022, 568.8492549474392, 600.2586805295457, 606.7694276175025, 628.4940622798691, 3732.869349572752, 3743.513343265358, 3813.809309534512, 3842.6733727633464, 3880.359740642819, 76740.0, 81934.0, 82556.58721706473, 83404.58297708472, 89969.0, 49445.0, 75036.0, 77227.61386193032, 77782.05544861424, 77872.61063694645, 67914.0, 68193.65903170552, 68635.65682171557, 68836.6558167216, 69691.0, 6634.706232284658, 7195.784126476214, 7686.57723825195, 7730.7680769577, 7811.960940195263, 48811.511884880696, 49606.759831004514, 50206.748966254934, 51169.0, 51498.48501514937, 62777.74444510993, 66213.0, 67086.0, 67494.66252668705, 68050.0, 9788.0, 9795.559199835881, 9977.20182385393, 10040.598376065167, 10457.372557646566, 10561.947190264, 10669.94665026701, 10739.516721747385, 10741.89258107409, 11031.558737650405, 10188.847167292348, 10206.13247873939, 10316.793664126826, 10630.468476576294, 10913.781724365626, 10230.693079207636, 10319.690409287734, 10573.841392378967, 10720.571177152826, 11140.164487663296, 9947.751306217402, 10029.197664186702, 10072.899271007196, 10317.432541210306, 10382.3251488653, 8233.135520770233, 8255.917440825515, 8459.703910363354, 8544.957275213585, 8547.059823419295, 7295.744648937474, 8102.513849169069, 8434.283085937765, 8467.957660211907, 8792.0], "unit": "score", "name": "yui.html", "value": 6617.045833940018}], "name": "dromaeo_css", "value": 7382.370864361039}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 108.0, 116.0, 113.0, 114.0, 128.0, 113.0, 114.0, 115.0, 113.0], "unit": "score", "name": "ai-astar", "value": 114.9}, {"lowerIsBetter": true, "replicates": [148.0, 122.0, 144.0, 158.0, 121.0, 142.0, 141.0, 124.0, 184.0, 145.0], "unit": "score", "name": "audio-beat-detection", "value": 142.9}, {"lowerIsBetter": true, "replicates": [194.0, 196.0, 200.0, 202.0, 211.0, 238.0, 195.0, 196.0, 204.0, 200.0], "unit": "score", "name": "audio-dft", "value": 203.6}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 58.0, 85.0, 81.0, 87.0, 96.0, 143.0, 56.0, 56.0], "unit": "score", "name": "audio-fft", "value": 80.7}, {"lowerIsBetter": true, "replicates": [90.0, 80.0, 118.0, 78.0, 79.0, 83.0, 119.0, 83.0, 79.0, 120.0], "unit": "score", "name": "audio-oscillator", "value": 92.9}, {"lowerIsBetter": true, "replicates": [92.0, 89.0, 91.0, 90.0, 93.0, 88.0, 93.0, 90.0, 92.0, 88.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 90.6}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 96.0, 97.0, 97.0, 97.0, 97.0, 106.0, 97.0, 133.0], "unit": "score", "name": "imaging-darkroom", "value": 101.4}, {"lowerIsBetter": true, "replicates": [89.0, 91.0, 99.0, 90.0, 92.0, 92.0, 91.0, 92.0, 92.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 91.8}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 56.0, 60.0, 64.0, 77.0, 88.0, 95.0, 57.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 66.6}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 81.0, 64.0, 84.0, 90.0, 105.0, 58.0, 87.0, 104.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 80.6}, {"lowerIsBetter": true, "replicates": [88.0, 87.0, 82.0, 84.0, 88.0, 91.0, 114.0, 77.0, 102.0, 111.0], "unit": "score", "name": "stanford-crypto-aes", "value": 92.4}, {"lowerIsBetter": true, "replicates": [129.0, 138.0, 124.0, 136.0, 137.0, 143.0, 144.0, 152.0, 143.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 137.1}, {"lowerIsBetter": true, "replicates": [161.0, 188.0, 187.0, 143.0, 139.0, 130.0, 142.0, 141.0, 139.0, 155.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.5}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 63.0, 69.0, 70.0, 70.0, 69.0, 69.0, 68.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1516.7}]} 04:58:26 INFO - Return code: 0 04:58:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:58:26 ERROR - # TBPL SUCCESS # 04:58:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:58:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:58:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:58:26 INFO - 2016-04-07 04:58:26.268 screenresolution[1710:10674] starting screenresolution argv=screenresolution get 04:58:26 INFO - 2016-04-07 04:58:26.271 screenresolution[1710:10674] Display 0: 1600x1200x32@60 04:58:26 INFO - 2016-04-07 04:58:26.277 screenresolution[1711:10677] starting screenresolution argv=screenresolution list 04:58:26 INFO - Available Modes on Display 0 04:58:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:58:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:58:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:58:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:58:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:58:26 INFO - Intel Iris: 04:58:26 INFO - Chipset Model: Intel Iris 04:58:26 INFO - Type: GPU 04:58:26 INFO - Bus: Built-In 04:58:26 INFO - VRAM (Dynamic, Max): 1536 MB 04:58:26 INFO - Vendor: Intel (0x8086) 04:58:26 INFO - Device ID: 0x0a2e 04:58:26 INFO - Revision ID: 0x0009 04:58:26 INFO - Displays: 04:58:26 INFO - Display: 04:58:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:58:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:58:26 INFO - Display Serial Number: 1600x1200 60 04:58:26 INFO - Main Display: Yes 04:58:26 INFO - Mirror: Off 04:58:26 INFO - Online: Yes 04:58:26 INFO - Rotation: Supported 04:58:26 INFO - Return code: 0 04:58:26 INFO - Running post-action listener: _resource_record_post_action 04:58:26 INFO - Running post-run listener: _resource_record_post_run 04:58:27 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 31862272; Write bytes: 699020800; Read time: 312; Write time: 2001 04:58:27 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 371167744; Write bytes: 364865024; Read time: 27909; Write time: 657 04:58:27 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 31530496; Write bytes: 300804096; Read time: 308; Write time: 1211 04:58:27 INFO - Running post-run listener: _upload_blobber_files 04:58:27 INFO - Blob upload gear active. 04:58:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:58:27 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 04:58:27 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'] 04:58:27 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 04:58:28 INFO - (blobuploader) - INFO - Open directory for files ... 04:58:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:58:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:58:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:58:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:58:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:58:28 INFO - (blobuploader) - INFO - Done attempting. 04:58:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:58:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:58:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:58:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:58:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:58:29 INFO - (blobuploader) - INFO - Done attempting. 04:58:29 INFO - (blobuploader) - INFO - Iteration through files over. 04:58:29 INFO - Return code: 0 04:58:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:58:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:58:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0172067e348dc9d0ab3ba31df9d594106c058330d92567545df1075d7dcfbc214ca7bdf6a373d5c1f6a7231546f7725254b4ba4f3d1aa63149af3012401156aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a66b627362d934b222a2893588d1bb19cbd9eb6c203dccc77abfbf443f9bac38d238d3cff690b5de1bd2f11f5a2fbb80d3809adb691cc9b8a9649f9ffec16281"} 04:58:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:58:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:58:29 INFO - Contents: 04:58:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0172067e348dc9d0ab3ba31df9d594106c058330d92567545df1075d7dcfbc214ca7bdf6a373d5c1f6a7231546f7725254b4ba4f3d1aa63149af3012401156aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a66b627362d934b222a2893588d1bb19cbd9eb6c203dccc77abfbf443f9bac38d238d3cff690b5de1bd2f11f5a2fbb80d3809adb691cc9b8a9649f9ffec16281"} 04:58:29 INFO - Running post-run listener: copy_logs_to_upload_dir 04:58:29 INFO - Copying logs to upload dir... 04:58:29 INFO - mkdir: /builds/slave/test/build/upload/logs 04:58:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.590649 ========= master_lag: 4.63 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-04-07 04:58:34.207863) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-04-07 04:58:34.215037) ========= 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.yqNkGaBCtR/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.QNbrZt2xPh/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0172067e348dc9d0ab3ba31df9d594106c058330d92567545df1075d7dcfbc214ca7bdf6a373d5c1f6a7231546f7725254b4ba4f3d1aa63149af3012401156aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a66b627362d934b222a2893588d1bb19cbd9eb6c203dccc77abfbf443f9bac38d238d3cff690b5de1bd2f11f5a2fbb80d3809adb691cc9b8a9649f9ffec16281"} 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.011250 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0172067e348dc9d0ab3ba31df9d594106c058330d92567545df1075d7dcfbc214ca7bdf6a373d5c1f6a7231546f7725254b4ba4f3d1aa63149af3012401156aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a66b627362d934b222a2893588d1bb19cbd9eb6c203dccc77abfbf443f9bac38d238d3cff690b5de1bd2f11f5a2fbb80d3809adb691cc9b8a9649f9ffec16281"}' ========= master_lag: 2.27 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-04-07 04:58:36.496670) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:58:36.500985) ========= 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.yqNkGaBCtR/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.QNbrZt2xPh/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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.005179 ========= master_lag: 0.22 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:58:36.722280) ========= ========= Started reboot skipped (results: 3, elapsed: 19 secs) (at 2016-04-07 04:58:36.722577) ========= ========= Finished reboot skipped (results: 3, elapsed: 19 secs) (at 2016-04-07 04:58:56.123113) ========= ========= Total master_lag: 45.99 =========