builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0130 starttime: 1460046594.47 results: success (0) buildid: 20160407091419 builduid: 86cf147fcc7f49978d75c67fbfcb6bfb revision: 1725b460c3e0de97590cb8764df9ace9115b813e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 09:29:54.474016) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 09:29:54.474358) ========= ========= Started set props: basedir (results: 0, elapsed: 11 secs) (at 2016-04-07 09:29:54.474660) ========= 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.yHYrppqM6R/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.D2cEOcTxq3/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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.005733 basedir: '/builds/slave/test' ========= master_lag: 11.58 ========= ========= Finished set props: basedir (results: 0, elapsed: 11 secs) (at 2016-04-07 09:30:06.063921) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 40 secs) (at 2016-04-07 09:30:06.064230) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 40 secs) (at 2016-04-07 09:30:46.430567) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 7 secs) (at 2016-04-07 09:30:46.430837) ========= 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.yHYrppqM6R/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.D2cEOcTxq3/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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.006052 ========= master_lag: 7.92 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 7 secs) (at 2016-04-07 09:30:54.356752) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 09:30:54.357026) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 09:30:54.357353) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 17 secs) (at 2016-04-07 09:30:54.357624) ========= 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.yHYrppqM6R/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.D2cEOcTxq3/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 09:30:56-- 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% 148M=0s 2016-04-07 09:30:57 (148 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.659853 ========= master_lag: 16.63 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 17 secs) (at 2016-04-07 09:31:11.651921) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 9 secs) (at 2016-04-07 09:31:11.652203) ========= 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.yHYrppqM6R/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.D2cEOcTxq3/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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.020636 ========= master_lag: 9.79 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 9 secs) (at 2016-04-07 09:31:21.462373) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 10 secs) (at 2016-04-07 09:31:21.462741) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1725b460c3e0de97590cb8764df9ace9115b813e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 1725b460c3e0de97590cb8764df9ace9115b813e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yHYrppqM6R/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.D2cEOcTxq3/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 09:31:21,951 truncating revision to first 12 chars 2016-04-07 09:31:21,951 Setting DEBUG logging. 2016-04-07 09:31:21,952 attempt 1/10 2016-04-07 09:31:21,952 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1725b460c3e0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-07 09:31:23,468 unpacking tar archive at: fx-team-1725b460c3e0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.769611 ========= master_lag: 8.28 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 10 secs) (at 2016-04-07 09:31:31.511833) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-04-07 09:31:31.512189) ========= echo 1725b460c3e0de97590cb8764df9ace9115b813e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1725b460c3e0de97590cb8764df9ace9115b813e'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yHYrppqM6R/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.D2cEOcTxq3/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 1725b460c3e0de97590cb8764df9ace9115b813e program finished with exit code 0 elapsedTime=0.005002 script_repo_revision: '1725b460c3e0de97590cb8764df9ace9115b813e' ========= master_lag: 1.19 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-04-07 09:31:32.706205) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 4 secs) (at 2016-04-07 09:31:32.706545) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 4 secs) (at 2016-04-07 09:31:36.768933) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-07 09:31:36.769349) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yHYrppqM6R/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.D2cEOcTxq3/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:31:37 INFO - MultiFileLogger online at 20160407 09:31:37 in /builds/slave/test 09:31:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:31:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:31:37 INFO - {'append_to_log': False, 09:31:37 INFO - 'base_work_dir': '/builds/slave/test', 09:31:37 INFO - 'blob_upload_branch': 'Fx-Team', 09:31:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:31:37 INFO - 'branch': 'Fx-Team', 09:31:37 INFO - 'buildbot_json_path': 'buildprops.json', 09:31:37 INFO - 'config_files': ('talos/mac_config.py',), 09:31:37 INFO - 'default_actions': ('clobber', 09:31:37 INFO - 'read-buildbot-config', 09:31:37 INFO - 'download-and-extract', 09:31:37 INFO - 'populate-webroot', 09:31:37 INFO - 'create-virtualenv', 09:31:37 INFO - 'install', 09:31:37 INFO - 'run-tests'), 09:31:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:31:37 INFO - 'download_minidump_stackwalk': True, 09:31:37 INFO - 'download_symbols': 'ondemand', 09:31:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:31:37 INFO - 'tooltool.py': '/tools/tooltool.py', 09:31:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:31:37 INFO - '/tools/misc-python/virtualenv.py')}, 09:31:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:31:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:31:37 INFO - 'installer_path': 'installer.exe', 09:31:37 INFO - 'log_level': 'info', 09:31:37 INFO - 'log_name': 'talos', 09:31:37 INFO - 'log_to_console': True, 09:31:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:31:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:31:37 INFO - 'opt_config_files': (), 09:31:37 INFO - 'pip_index': False, 09:31:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:31:37 INFO - 'cmd': ('bash', 09:31:37 INFO - '-c', 09:31:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:31:37 INFO - 'enabled': True, 09:31:37 INFO - 'halt_on_failure': False, 09:31:37 INFO - 'name': 'check_screen_resolution'},), 09:31:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:31:37 INFO - 'cmd': ('bash', 09:31:37 INFO - '-c', 09:31:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:31:37 INFO - 'enabled': True, 09:31:37 INFO - 'halt_on_failure': False, 09:31:37 INFO - 'name': 'check_screen_resolution'},), 09:31:37 INFO - 'run_cmd_checks_enabled': True, 09:31:37 INFO - 'sps_profile': False, 09:31:37 INFO - 'sps_profile_interval': 0, 09:31:37 INFO - 'suite': 'dromaeojs-e10s', 09:31:37 INFO - 'system_bits': '32', 09:31:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:31:37 INFO - 'title': 't-yosemite-r7-0130', 09:31:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:31:37 INFO - 'use_talos_json': True, 09:31:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:31:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:31:37 INFO - 'work_dir': 'build'} 09:31:37 INFO - ##### 09:31:37 INFO - ##### Running clobber step. 09:31:37 INFO - ##### 09:31:37 INFO - Running pre-action listener: _resource_record_pre_action 09:31:37 INFO - Running main action method: clobber 09:31:37 INFO - rmtree: /builds/slave/test/build 09:31:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:31:39 INFO - Running post-action listener: _resource_record_post_action 09:31:39 INFO - ##### 09:31:39 INFO - ##### Running read-buildbot-config step. 09:31:39 INFO - ##### 09:31:39 INFO - Running pre-action listener: _resource_record_pre_action 09:31:39 INFO - Running main action method: read_buildbot_config 09:31:39 INFO - Using buildbot properties: 09:31:39 INFO - { 09:31:39 INFO - "project": "", 09:31:39 INFO - "product": "firefox", 09:31:39 INFO - "script_repo_revision": "production", 09:31:39 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 09:31:39 INFO - "repository": "", 09:31:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 09:31:39 INFO - "buildid": "20160407091419", 09:31:39 INFO - "stage_platform": "macosx64", 09:31:39 INFO - "basedir": "/builds/slave/test", 09:31:39 INFO - "buildnumber": 665, 09:31:39 INFO - "platform": "yosemite_r7", 09:31:39 INFO - "mozci_request": { 09:31:39 INFO - "priority": -1, 09:31:39 INFO - "type": "trigger_all_talos_jobs", 09:31:39 INFO - "times": 6 09:31:39 INFO - }, 09:31:39 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:31:39 INFO - "slavebuilddir": "test", 09:31:39 INFO - "branch": "fx-team", 09:31:39 INFO - "revision": "1725b460c3e0de97590cb8764df9ace9115b813e", 09:31:39 INFO - "slavename": "t-yosemite-r7-0130", 09:31:39 INFO - "builduid": "86cf147fcc7f49978d75c67fbfcb6bfb", 09:31:39 INFO - "repo_path": "integration/fx-team" 09:31:39 INFO - } 09:31:39 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459966130/firefox-48.0a1.en-US.mac.dmg. 09:31:39 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459966130/firefox-48.0a1.en-US.mac.test_packages.json. 09:31:39 INFO - Running post-action listener: _resource_record_post_action 09:31:39 INFO - ##### 09:31:39 INFO - ##### Running download-and-extract step. 09:31:39 INFO - ##### 09:31:39 INFO - Running pre-action listener: _resource_record_pre_action 09:31:39 INFO - Running main action method: download_and_extract 09:31:39 INFO - mkdir: /builds/slave/test/build/tests 09:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:39 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459966130/firefox-48.0a1.en-US.mac.test_packages.json 09:31:39 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459966130/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 09:31:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459966130/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 09:31:39 INFO - Downloaded 1199 bytes. 09:31:39 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 09:31:39 INFO - Using the following test package requirements: 09:31:39 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:31:39 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:31:39 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 09:31:39 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:31:39 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 09:31:39 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:31:39 INFO - u'jsshell-mac.zip'], 09:31:39 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:31:39 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 09:31:39 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:31:39 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:31:39 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 09:31:39 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:31:39 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 09:31:39 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:31:39 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 09:31:39 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:31:39 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 09:31:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:39 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459966130/firefox-48.0a1.en-US.mac.common.tests.zip 09:31:39 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459966130/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:31:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459966130/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 09:31:39 INFO - Downloaded 17970713 bytes. 09:31:39 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'] 09:31:39 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 09:31:43 INFO - Return code: 0 09:31:43 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 09:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:43 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459966130/firefox-48.0a1.en-US.mac.common.tests.zip 09:31:43 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459966130/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:31:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459966130/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 09:31:43 INFO - Downloaded 17970713 bytes. 09:31:43 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'] 09:31:43 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 09:31:46 INFO - Return code: 0 09:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:46 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459966130/firefox-48.0a1.en-US.mac.talos.tests.zip 09:31:46 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459966130/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:31:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459966130/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 09:31:47 INFO - Downloaded 10847617 bytes. 09:31:47 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'] 09:31:47 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 09:31:47 INFO - Return code: 0 09:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:47 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459966130/firefox-48.0a1.en-US.mac.dmg 09:31:47 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459966130/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 09:31:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459966130/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 09:31:49 INFO - Downloaded 108918030 bytes. 09:31:49 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459966130/firefox-48.0a1.en-US.mac.dmg 09:31:49 INFO - mkdir: /builds/slave/test/properties 09:31:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:31:49 INFO - Writing to file /builds/slave/test/properties/build_url 09:31:49 INFO - Contents: 09:31:49 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459966130/firefox-48.0a1.en-US.mac.dmg 09:31:49 INFO - Running post-action listener: _resource_record_post_action 09:31:49 INFO - Running post-action listener: set_extra_try_arguments 09:31:49 INFO - ##### 09:31:49 INFO - ##### Running populate-webroot step. 09:31:49 INFO - ##### 09:31:49 INFO - Running pre-action listener: _resource_record_pre_action 09:31:49 INFO - Running main action method: populate_webroot 09:31:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:31:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:31:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:31:49 INFO - '--tppagecycles', 09:31:49 INFO - '7'], 09:31:49 INFO - 'tests': ['tsvgm']}}, 09:31:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:31:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:31:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:31:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:31:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:31:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:31:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:49 INFO - 'talos_options': ['--disable-e10s'], 09:31:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:31:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:31:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:49 INFO - 'talos_options': ['--disable-e10s'], 09:31:49 INFO - 'tests': ['damp', 'tps']}, 09:31:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:49 INFO - 'tests': ['damp', 'tps']}, 09:31:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:31:49 INFO - 'tests': ['dromaeo_dom']}, 09:31:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:31:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:31:49 INFO - 'tests': ['a11yr', 09:31:49 INFO - 'ts_paint', 09:31:49 INFO - 'tpaint', 09:31:49 INFO - 'sessionrestore', 09:31:49 INFO - 'sessionrestore_no_auto_restore', 09:31:49 INFO - 'tabpaint']}, 09:31:49 INFO - 'other-e10s': {'tests': ['a11yr', 09:31:49 INFO - 'ts_paint', 09:31:49 INFO - 'tpaint', 09:31:49 INFO - 'sessionrestore', 09:31:49 INFO - 'sessionrestore_no_auto_restore', 09:31:49 INFO - 'tabpaint']}, 09:31:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:31:49 INFO - 'ts_paint', 09:31:49 INFO - 'tpaint', 09:31:49 INFO - 'sessionrestore', 09:31:49 INFO - 'sessionrestore_no_auto_restore', 09:31:49 INFO - 'tabpaint']}, 09:31:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:31:49 INFO - 'ts_paint', 09:31:49 INFO - 'tpaint', 09:31:49 INFO - 'sessionrestore', 09:31:49 INFO - 'sessionrestore_no_auto_restore', 09:31:49 INFO - 'tabpaint']}, 09:31:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:31:49 INFO - 'tests': ['a11yr', 09:31:49 INFO - 'ts_paint', 09:31:49 INFO - 'tpaint', 09:31:49 INFO - 'sessionrestore', 09:31:49 INFO - 'sessionrestore_no_auto_restore', 09:31:49 INFO - 'tabpaint']}, 09:31:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:31:49 INFO - 'tests': ['a11yr', 09:31:49 INFO - 'ts_paint', 09:31:49 INFO - 'tpaint', 09:31:49 INFO - 'sessionrestore', 09:31:49 INFO - 'sessionrestore_no_auto_restore', 09:31:49 INFO - 'tabpaint']}, 09:31:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:31:49 INFO - 'tests': ['tsvgx', 09:31:49 INFO - 'tsvgr_opacity', 09:31:49 INFO - 'tart', 09:31:49 INFO - 'tscrollx', 09:31:49 INFO - 'cart']}, 09:31:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:31:49 INFO - 'tsvgr_opacity', 09:31:49 INFO - 'tart', 09:31:49 INFO - 'tscrollx', 09:31:49 INFO - 'cart']}, 09:31:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:49 INFO - 'talos_options': ['--disable-e10s'], 09:31:49 INFO - 'tests': ['tp5o']}, 09:31:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:49 INFO - 'tests': ['tp5o']}, 09:31:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:49 INFO - 'talos_options': ['--disable-e10s', 09:31:49 INFO - '--xperf_path', 09:31:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:31:49 INFO - 'tests': ['tp5n']}, 09:31:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:49 INFO - 'talos_options': ['--xperf_path', 09:31:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:31:49 INFO - 'tests': ['tp5n']}}, 09:31:49 INFO - 'talos.zip': {'path': '', 09:31:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:31:49 INFO - Running post-action listener: _resource_record_post_action 09:31:49 INFO - ##### 09:31:49 INFO - ##### Running create-virtualenv step. 09:31:49 INFO - ##### 09:31:49 INFO - Running pre-action listener: _resource_record_pre_action 09:31:49 INFO - Running main action method: create_virtualenv 09:31:49 INFO - Creating virtualenv /builds/slave/test/build/venv 09:31:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:31:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:31:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:31:49 INFO - Using real prefix '/tools/python27' 09:31:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:31:50 INFO - Installing distribute.............................................................................................................................................................................................done. 09:31:53 INFO - Installing pip.................done. 09:31:53 INFO - Return code: 0 09:31:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:53 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 0x10eb48a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb58420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92594aa8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e7e00>, '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 0x10e850db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e2b20>, '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.yHYrppqM6R/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.D2cEOcTxq3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:31:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:31:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yHYrppqM6R/Render', 09:31:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:53 INFO - 'HOME': '/Users/cltbld', 09:31:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:53 INFO - 'LOGNAME': 'cltbld', 09:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:53 INFO - 'MOZ_NO_REMOTE': '1', 09:31:53 INFO - 'NO_EM_RESTART': '1', 09:31:53 INFO - 'PAGER': '/bin/cat', 09:31:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:53 INFO - 'PWD': '/builds/slave/test', 09:31:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:53 INFO - 'SHELL': '/bin/bash', 09:31:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D2cEOcTxq3/Listeners', 09:31:53 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 09:31:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:53 INFO - 'USER': 'cltbld', 09:31:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:53 INFO - 'XPC_FLAGS': '0x0', 09:31:53 INFO - 'XPC_SERVICE_NAME': '0', 09:31:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:31:53 INFO - Cleaning up... 09:31:53 INFO - Return code: 0 09:31:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:53 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 0x10eb48a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb58420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92594aa8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e7e00>, '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 0x10e850db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e2b20>, '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.yHYrppqM6R/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.D2cEOcTxq3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:31:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:31:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yHYrppqM6R/Render', 09:31:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:53 INFO - 'HOME': '/Users/cltbld', 09:31:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:53 INFO - 'LOGNAME': 'cltbld', 09:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:53 INFO - 'MOZ_NO_REMOTE': '1', 09:31:53 INFO - 'NO_EM_RESTART': '1', 09:31:53 INFO - 'PAGER': '/bin/cat', 09:31:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:53 INFO - 'PWD': '/builds/slave/test', 09:31:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:53 INFO - 'SHELL': '/bin/bash', 09:31:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D2cEOcTxq3/Listeners', 09:31:53 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 09:31:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:53 INFO - 'USER': 'cltbld', 09:31:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:53 INFO - 'XPC_FLAGS': '0x0', 09:31:53 INFO - 'XPC_SERVICE_NAME': '0', 09:31:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:53 INFO - Downloading/unpacking psutil>=0.7.1 09:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:31:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:31:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:31:57 INFO - Installing collected packages: psutil 09:31:57 INFO - Running setup.py install for psutil 09:31:57 INFO - building 'psutil._psutil_osx' extension 09:31:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:31:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:31:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:31:57 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:31:57 INFO - building 'psutil._psutil_posix' extension 09:31:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:31:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:31:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:31:58 INFO - ^ 09:31:58 INFO - 1 warning generated. 09:31:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:31:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:31:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:31:58 INFO - Successfully installed psutil 09:31:58 INFO - Cleaning up... 09:31:58 INFO - Return code: 0 09:31:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10eb48a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb58420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92594aa8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e7e00>, '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 0x10e850db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e2b20>, '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.yHYrppqM6R/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.D2cEOcTxq3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:31:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:31:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:31:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yHYrppqM6R/Render', 09:31:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:58 INFO - 'HOME': '/Users/cltbld', 09:31:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:58 INFO - 'LOGNAME': 'cltbld', 09:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:58 INFO - 'MOZ_NO_REMOTE': '1', 09:31:58 INFO - 'NO_EM_RESTART': '1', 09:31:58 INFO - 'PAGER': '/bin/cat', 09:31:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:58 INFO - 'PWD': '/builds/slave/test', 09:31:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:58 INFO - 'SHELL': '/bin/bash', 09:31:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D2cEOcTxq3/Listeners', 09:31:58 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 09:31:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:58 INFO - 'USER': 'cltbld', 09:31:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:58 INFO - 'XPC_FLAGS': '0x0', 09:31:58 INFO - 'XPC_SERVICE_NAME': '0', 09:31:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:32:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:32:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:32:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:32:01 INFO - Installing collected packages: mozsystemmonitor 09:32:01 INFO - Running setup.py install for mozsystemmonitor 09:32:01 INFO - Successfully installed mozsystemmonitor 09:32:01 INFO - Cleaning up... 09:32:01 INFO - Return code: 0 09:32:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10eb48a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb58420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92594aa8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e7e00>, '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 0x10e850db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e2b20>, '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.yHYrppqM6R/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.D2cEOcTxq3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:32:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:32:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yHYrppqM6R/Render', 09:32:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:01 INFO - 'HOME': '/Users/cltbld', 09:32:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:01 INFO - 'LOGNAME': 'cltbld', 09:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:01 INFO - 'MOZ_NO_REMOTE': '1', 09:32:01 INFO - 'NO_EM_RESTART': '1', 09:32:01 INFO - 'PAGER': '/bin/cat', 09:32:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:01 INFO - 'PWD': '/builds/slave/test', 09:32:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:01 INFO - 'SHELL': '/bin/bash', 09:32:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D2cEOcTxq3/Listeners', 09:32:01 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 09:32:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:01 INFO - 'USER': 'cltbld', 09:32:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:01 INFO - 'XPC_FLAGS': '0x0', 09:32:01 INFO - 'XPC_SERVICE_NAME': '0', 09:32:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:01 INFO - Downloading/unpacking blobuploader==1.2.4 09:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:03 INFO - Downloading blobuploader-1.2.4.tar.gz 09:32:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:32:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:32:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:05 INFO - Downloading docopt-0.6.1.tar.gz 09:32:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:32:05 INFO - Installing collected packages: blobuploader, requests, docopt 09:32:05 INFO - Running setup.py install for blobuploader 09:32:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:32:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:32:05 INFO - Running setup.py install for requests 09:32:05 INFO - Running setup.py install for docopt 09:32:05 INFO - Successfully installed blobuploader requests docopt 09:32:05 INFO - Cleaning up... 09:32:06 INFO - Return code: 0 09:32:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:06 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 0x10eb48a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb58420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92594aa8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e7e00>, '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 0x10e850db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e2b20>, '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.yHYrppqM6R/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.D2cEOcTxq3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:32:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:32:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yHYrppqM6R/Render', 09:32:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:06 INFO - 'HOME': '/Users/cltbld', 09:32:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:06 INFO - 'LOGNAME': 'cltbld', 09:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:06 INFO - 'MOZ_NO_REMOTE': '1', 09:32:06 INFO - 'NO_EM_RESTART': '1', 09:32:06 INFO - 'PAGER': '/bin/cat', 09:32:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:06 INFO - 'PWD': '/builds/slave/test', 09:32:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:06 INFO - 'SHELL': '/bin/bash', 09:32:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D2cEOcTxq3/Listeners', 09:32:06 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 09:32:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:06 INFO - 'USER': 'cltbld', 09:32:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:06 INFO - 'XPC_FLAGS': '0x0', 09:32:06 INFO - 'XPC_SERVICE_NAME': '0', 09:32:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:32:06 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-loHdoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:32:06 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-DiLLkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:32:06 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-kNgZZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:32:06 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-bG9wKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:32:06 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-NW6Ksd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:32:06 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-Vnc3SN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:32:06 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-m1jFKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:32:07 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-9WuhY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:32:07 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-l1Vob_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:32:07 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-u4G6d_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:32:07 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-FSb_G2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:32:07 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-jhZiwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:32:07 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-rmVTL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:32:07 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-f86Y0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:07 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-wjgEV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:32:07 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-GBfRQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:32:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:32:08 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-UPFjHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:32:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:32:08 INFO - Running setup.py install for manifestparser 09:32:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:32:08 INFO - Running setup.py install for mozcrash 09:32:08 INFO - Running setup.py install for mozdebug 09:32:08 INFO - Running setup.py install for mozdevice 09:32:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:32:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:32:08 INFO - Running setup.py install for mozfile 09:32:08 INFO - Running setup.py install for mozhttpd 09:32:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:32:09 INFO - Running setup.py install for mozinfo 09:32:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:32:09 INFO - Running setup.py install for mozInstall 09:32:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:32:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:32:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:32:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:32:09 INFO - Running setup.py install for mozleak 09:32:09 INFO - Running setup.py install for mozlog 09:32:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:32:09 INFO - Running setup.py install for moznetwork 09:32:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:32:09 INFO - Running setup.py install for mozprocess 09:32:09 INFO - Running setup.py install for mozprofile 09:32:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:32:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:32:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:32:10 INFO - Running setup.py install for mozrunner 09:32:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:32:10 INFO - Running setup.py install for mozscreenshot 09:32:10 INFO - Running setup.py install for moztest 09:32:10 INFO - Running setup.py install for mozversion 09:32:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:32:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:32:10 INFO - Cleaning up... 09:32:10 INFO - Return code: 0 09:32:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:10 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 0x10eb48a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb58420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92594aa8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e7e00>, '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 0x10e850db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e2b20>, '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.yHYrppqM6R/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.D2cEOcTxq3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:32:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:32:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:32:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yHYrppqM6R/Render', 09:32:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:10 INFO - 'HOME': '/Users/cltbld', 09:32:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:10 INFO - 'LOGNAME': 'cltbld', 09:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:10 INFO - 'MOZ_NO_REMOTE': '1', 09:32:10 INFO - 'NO_EM_RESTART': '1', 09:32:10 INFO - 'PAGER': '/bin/cat', 09:32:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:10 INFO - 'PWD': '/builds/slave/test', 09:32:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:10 INFO - 'SHELL': '/bin/bash', 09:32:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D2cEOcTxq3/Listeners', 09:32:10 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 09:32:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:10 INFO - 'USER': 'cltbld', 09:32:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:10 INFO - 'XPC_FLAGS': '0x0', 09:32:10 INFO - 'XPC_SERVICE_NAME': '0', 09:32:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:32:11 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-VlreeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:32:11 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-ScE0kW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:32:11 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)) 09:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:32:11 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-yp_UxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:32:11 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-RHKQuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:32:11 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-YEdnDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:32:11 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-RdV8rZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:32:11 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-O1FjAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:32:11 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-34mrhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:32:11 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-QKDYy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:32:11 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-oxJL7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:32:12 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-B4_BW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:32:12 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-eG8faz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:32:12 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-E6Senz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:32:12 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-zSqG2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:12 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-WwAgl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:32:12 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-5Yiq4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:32:12 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-BcwKpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:32:12 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)) 09:32:12 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)) 09:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:32:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:32:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:15 INFO - Downloading blessings-1.6.tar.gz 09:32:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:32:15 INFO - Installing collected packages: blessings 09:32:15 INFO - Running setup.py install for blessings 09:32:15 INFO - Successfully installed blessings 09:32:15 INFO - Cleaning up... 09:32:15 INFO - Return code: 0 09:32:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:32:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:32:15 INFO - Reading from file tmpfile_stdout 09:32:15 INFO - Current package versions: 09:32:15 INFO - blessings == 1.6 09:32:15 INFO - blobuploader == 1.2.4 09:32:15 INFO - docopt == 0.6.1 09:32:15 INFO - manifestparser == 1.1 09:32:15 INFO - mozInstall == 1.12 09:32:15 INFO - mozcrash == 0.17 09:32:15 INFO - mozdebug == 0.1 09:32:15 INFO - mozdevice == 0.48 09:32:15 INFO - mozfile == 1.2 09:32:15 INFO - mozhttpd == 0.7 09:32:15 INFO - mozinfo == 0.9 09:32:15 INFO - mozleak == 0.1 09:32:15 INFO - mozlog == 3.1 09:32:15 INFO - moznetwork == 0.27 09:32:15 INFO - mozprocess == 0.22 09:32:15 INFO - mozprofile == 0.28 09:32:15 INFO - mozrunner == 6.11 09:32:15 INFO - mozscreenshot == 0.1 09:32:15 INFO - mozsystemmonitor == 0.0 09:32:15 INFO - moztest == 0.7 09:32:15 INFO - mozversion == 1.4 09:32:15 INFO - psutil == 3.1.1 09:32:15 INFO - requests == 1.2.3 09:32:15 INFO - wsgiref == 0.1.2 09:32:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:15 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 0x10eb48a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb58420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92594aa8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e7e00>, '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 0x10e850db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e2b20>, '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.yHYrppqM6R/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.D2cEOcTxq3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:32:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:32:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yHYrppqM6R/Render', 09:32:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:15 INFO - 'HOME': '/Users/cltbld', 09:32:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:15 INFO - 'LOGNAME': 'cltbld', 09:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:15 INFO - 'MOZ_NO_REMOTE': '1', 09:32:15 INFO - 'NO_EM_RESTART': '1', 09:32:15 INFO - 'PAGER': '/bin/cat', 09:32:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:15 INFO - 'PWD': '/builds/slave/test', 09:32:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:15 INFO - 'SHELL': '/bin/bash', 09:32:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D2cEOcTxq3/Listeners', 09:32:15 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 09:32:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:15 INFO - 'USER': 'cltbld', 09:32:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:15 INFO - 'XPC_FLAGS': '0x0', 09:32:15 INFO - 'XPC_SERVICE_NAME': '0', 09:32:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:32:16 INFO - Cleaning up... 09:32:16 INFO - Return code: 0 09:32:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:32: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')]} 09:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32: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')]} 09:32:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10eb48a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb58420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92594aa8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e7e00>, '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 0x10e850db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e2b20>, '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.yHYrppqM6R/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.D2cEOcTxq3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:32: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', 'jsonschema'] in /builds/slave/test/build 09:32: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 jsonschema 09:32:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yHYrppqM6R/Render', 09:32:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:16 INFO - 'HOME': '/Users/cltbld', 09:32:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:16 INFO - 'LOGNAME': 'cltbld', 09:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:16 INFO - 'MOZ_NO_REMOTE': '1', 09:32:16 INFO - 'NO_EM_RESTART': '1', 09:32:16 INFO - 'PAGER': '/bin/cat', 09:32:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:16 INFO - 'PWD': '/builds/slave/test', 09:32:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:16 INFO - 'SHELL': '/bin/bash', 09:32:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D2cEOcTxq3/Listeners', 09:32:16 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 09:32:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:16 INFO - 'USER': 'cltbld', 09:32:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:16 INFO - 'XPC_FLAGS': '0x0', 09:32:16 INFO - 'XPC_SERVICE_NAME': '0', 09:32:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:16 INFO - Downloading/unpacking jsonschema 09:32: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 09:32: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 09:32: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 09:32: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 09:32: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 09:32: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 09:32:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:32:18 INFO - Downloading/unpacking functools32 (from jsonschema) 09:32: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 09:32: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 09:32: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 09:32: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 09:32: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 09:32: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 09:32:19 INFO - Downloading functools32-3.2.3-2.tar.gz 09:32:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:32:19 INFO - warning: no files found matching '*.txt' 09:32:19 INFO - no previously-included directories found matching 'build' 09:32:19 INFO - no previously-included directories found matching 'dist' 09:32:19 INFO - no previously-included directories found matching '.git*' 09:32:19 INFO - Installing collected packages: jsonschema, functools32 09:32:19 INFO - Running setup.py install for functools32 09:32:19 INFO - warning: no files found matching '*.txt' 09:32:19 INFO - no previously-included directories found matching 'build' 09:32:19 INFO - no previously-included directories found matching 'dist' 09:32:19 INFO - no previously-included directories found matching '.git*' 09:32:19 INFO - Successfully installed jsonschema functools32 09:32:19 INFO - Cleaning up... 09:32:19 INFO - Return code: 0 09:32:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:32: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')]} 09:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32: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')]} 09:32:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10eb48a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb58420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92594aa8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e7e00>, '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 0x10e850db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e2b20>, '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.yHYrppqM6R/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.D2cEOcTxq3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:32:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:32:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yHYrppqM6R/Render', 09:32:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:19 INFO - 'HOME': '/Users/cltbld', 09:32:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:19 INFO - 'LOGNAME': 'cltbld', 09:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:19 INFO - 'MOZ_NO_REMOTE': '1', 09:32:19 INFO - 'NO_EM_RESTART': '1', 09:32:19 INFO - 'PAGER': '/bin/cat', 09:32:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:19 INFO - 'PWD': '/builds/slave/test', 09:32:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:19 INFO - 'SHELL': '/bin/bash', 09:32:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D2cEOcTxq3/Listeners', 09:32:19 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 09:32:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:19 INFO - 'USER': 'cltbld', 09:32:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:19 INFO - 'XPC_FLAGS': '0x0', 09:32:19 INFO - 'XPC_SERVICE_NAME': '0', 09:32:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:19 INFO - Downloading/unpacking flake8 09:32: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 09:32: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 09:32: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 09:32: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 09:32: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 09:32: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 09:32:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:32:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:32:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:32:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:32:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:32:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:32:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:32:23 INFO - no previously-included directories found matching 'docs/_build' 09:32:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:32:23 INFO - Running setup.py install for pep8 09:32:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:32:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:32:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:32:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:32:23 INFO - no previously-included directories found matching 'docs/_build' 09:32:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:32:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:32:23 INFO - Cleaning up... 09:32:24 INFO - Return code: 0 09:32:24 INFO - Running post-action listener: _resource_record_post_action 09:32:24 INFO - Running post-action listener: _start_resource_monitoring 09:32:24 INFO - Starting resource monitoring. 09:32:24 INFO - ##### 09:32:24 INFO - ##### Running install step. 09:32:24 INFO - ##### 09:32:24 INFO - Running pre-action listener: _resource_record_pre_action 09:32:24 INFO - Running main action method: install 09:32:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:32:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:32:24 INFO - Reading from file tmpfile_stdout 09:32:24 INFO - Detecting whether we're running mozinstall >=1.0... 09:32:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:32:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:32:24 INFO - Reading from file tmpfile_stdout 09:32:24 INFO - Output received: 09:32:24 INFO - Usage: mozinstall [options] installer 09:32:24 INFO - Options: 09:32:24 INFO - -h, --help show this help message and exit 09:32:24 INFO - -d DEST, --destination=DEST 09:32:24 INFO - Directory to install application into. [default: 09:32:24 INFO - "/builds/slave/test"] 09:32:24 INFO - --app=APP Application being installed. [default: firefox] 09:32:24 INFO - mkdir: /builds/slave/test/build/application 09:32:24 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'] 09:32:24 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 09:32:58 INFO - Reading from file tmpfile_stdout 09:32:58 INFO - Output received: 09:32:58 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:32:58 INFO - Running post-action listener: _resource_record_post_action 09:32:58 INFO - ##### 09:32:58 INFO - ##### Running run-tests step. 09:32:58 INFO - ##### 09:32:58 INFO - Running pre-action listener: _resource_record_pre_action 09:32:58 INFO - Running main action method: run_tests 09:32:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:32:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:32:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:32:58 INFO - 2016-04-07 09:32:58.518 screenresolution[1971:18888] starting screenresolution argv=screenresolution get 09:32:58 INFO - 2016-04-07 09:32:58.521 screenresolution[1971:18888] Display 0: 1600x1200x32@60 09:32:58 INFO - 2016-04-07 09:32:58.527 screenresolution[1972:18890] starting screenresolution argv=screenresolution list 09:32:58 INFO - Available Modes on Display 0 09:32:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:32:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:32:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:32:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:32:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:32:58 INFO - Intel Iris: 09:32:58 INFO - Chipset Model: Intel Iris 09:32:58 INFO - Type: GPU 09:32:58 INFO - Bus: Built-In 09:32:58 INFO - VRAM (Dynamic, Max): 1536 MB 09:32:58 INFO - Vendor: Intel (0x8086) 09:32:58 INFO - Device ID: 0x0a2e 09:32:58 INFO - Revision ID: 0x0009 09:32:58 INFO - Displays: 09:32:58 INFO - Display: 09:32:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:32:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:32:58 INFO - Display Serial Number: 1600x1200 60 09:32:58 INFO - Main Display: Yes 09:32:58 INFO - Mirror: Off 09:32:58 INFO - Online: Yes 09:32:58 INFO - Rotation: Supported 09:32:58 INFO - Return code: 0 09:32:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:32:58 INFO - Python 2.7.3 09:32:58 INFO - Return code: 0 09:32:58 INFO - grabbing minidump binary from tooltool 09:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:58 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 0x10e9e7e00>, '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 0x10e850db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9e2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:32:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:32:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:32:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:32:58 INFO - Return code: 0 09:32:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:32:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:32:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:32:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:32:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:32:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:33:00 INFO - Return code: 0 09:33:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459966130/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0130', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459966130/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0130 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:33:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yHYrppqM6R/Render', 09:33:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:00 INFO - 'HOME': '/Users/cltbld', 09:33:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:00 INFO - 'LOGNAME': 'cltbld', 09:33:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:33:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:00 INFO - 'MOZ_NO_REMOTE': '1', 09:33:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:33:00 INFO - 'NO_EM_RESTART': '1', 09:33:00 INFO - 'PAGER': '/bin/cat', 09:33:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:00 INFO - 'PWD': '/builds/slave/test', 09:33:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:33:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:00 INFO - 'SHELL': '/bin/bash', 09:33:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.D2cEOcTxq3/Listeners', 09:33:00 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 09:33:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:00 INFO - 'USER': 'cltbld', 09:33:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:00 INFO - 'XPC_FLAGS': '0x0', 09:33:00 INFO - 'XPC_SERVICE_NAME': '0', 09:33:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459966130/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0130', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:33:00 INFO - mozversion application_buildid: 20160406110850 09:33:00 INFO - mozversion application_changeset: 1725b460c3e0de97590cb8764df9ace9115b813e 09:33:00 INFO - mozversion application_display_name: Nightly 09:33:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:33:00 INFO - mozversion application_name: Firefox 09:33:00 INFO - mozversion application_remotingname: firefox 09:33:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:33:00 INFO - mozversion application_vendor: Mozilla 09:33:00 INFO - mozversion application_version: 48.0a1 09:33:00 INFO - mozversion platform_buildid: 20160406110850 09:33:00 INFO - mozversion platform_changeset: 1725b460c3e0de97590cb8764df9ace9115b813e 09:33:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:33:00 INFO - mozversion platform_version: 48.0a1 09:33:00 INFO - using testdate: 1460046780 09:33:00 INFO - actual date: 1460046780 09:33:00 INFO - starting webserver on 'localhost:57150' 09:33:00 INFO - SUITE-START | Running 2 tests 09:33:00 INFO - TEST-START | dromaeo_css 09:33:00 INFO - operating with platform_type : mac_ 09:33:00 INFO - Initialising browser for dromaeo_css test... 09:33:00 INFO - TEST-INFO | started process 1990 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/tmpLacHke/profile http://localhost:57150/getInfo.html) 09:33:02 INFO - PROCESS | 1990 | 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] 09:33:03 INFO - PROCESS | 1990 | __metrics Screen width/height:1600/1200 09:33:03 INFO - PROCESS | 1990 | colorDepth:24 09:33:03 INFO - PROCESS | 1990 | Browser inner width/height: 1024/689 09:33:03 INFO - PROCESS | 1990 | __metrics 09:33:03 ERROR - PROCESS | 1990 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 09:33:03 INFO - TEST-INFO | 1990: exit 0 09:33:03 INFO - Browser initialized. 09:33:03 INFO - Running cycle 1/1 for dromaeo_css test... 09:33:03 INFO - TEST-INFO | started process 1993 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/tmpLacHke/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:33:15 INFO - PROCESS | 1993 | RSS: Main: 246882304 09:33:15 INFO - PROCESS | 1993 | 09:34:05 INFO - PROCESS | 1993 | 1460046845167 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:36:16 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:57150/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57150/tests/dromaeo/cssquery-ext.html) 09:36:17 INFO - PROCESS | 1993 | RSS: Main: 258854912 09:36:17 INFO - PROCESS | 1993 | 09:39:19 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:57150/tests/dromaeo/cssquery-ext.html (next: http://localhost:57150/tests/dromaeo/cssquery-jquery.html) 09:39:20 INFO - PROCESS | 1993 | RSS: Main: 270893056 09:39:20 INFO - PROCESS | 1993 | 09:42:21 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:57150/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57150/tests/dromaeo/cssquery-mootools.html) 09:42:22 INFO - PROCESS | 1993 | RSS: Main: 272359424 09:42:22 INFO - PROCESS | 1993 | 09:45:24 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:57150/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57150/tests/dromaeo/cssquery-prototype.html) 09:45:24 INFO - PROCESS | 1993 | RSS: Main: 275898368 09:45:24 INFO - PROCESS | 1993 | 09:48:27 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:57150/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57150/tests/dromaeo/cssquery-yui.html) 09:48:28 INFO - PROCESS | 1993 | RSS: Main: 275587072 09:48:28 INFO - PROCESS | 1993 | 09:51:30 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:57150/tests/dromaeo/cssquery-yui.html (next: http://localhost:57150/tests/dromaeo/cssquery-dojo.html) 09:51:30 INFO - PROCESS | 1993 | RSS: Main: 279453696 09:51:30 INFO - PROCESS | 1993 | 09:51:30 INFO - PROCESS | 1993 | __start_tp_report 09:51:30 INFO - PROCESS | 1993 | _x_x_mozilla_page_load 09:51:30 INFO - PROCESS | 1993 | _x_x_mozilla_page_load_details 09:51:30 INFO - PROCESS | 1993 | |i|pagename|runs| 09:51:30 INFO - PROCESS | 1993 | |0;dojo.html;3009.6388433387997;3088.3360077583316;3413.9146521336966;3484.9477257841136;3514.5782506099263;5654.434556544344;5660.094384898417;5680.11958146488;5690.829275121742;5719.513841323487;5550.4449555044475;5680.233168522248;5702.372738998707;5808.04167312394;5821.53427725782;5091.770870310845;5137.7944882204665;5174.327337446146;5211;5213.530782229599;5163.483651634844;5164.2770012198325;5170.974145129269;5218.347706536683;5233.2150177473495;4795.592374648177;4880.536349046835;5076;5179.689218646893;5209.973950130263;5114.948850511521;5149.538117755042;5167.354080739908;5179.067767801795;5208.348956380452;4961.603071754251;5024.397072351305;5136.794528218867;5148.897022059537;5153.201253805666;4163.895902602429;5576.470235327637;5605.243292155547;5626.634268772516;5664.631798933097;5118.61610379223;6141.802348542036;6191.133241346215;6229.439350458435;6278.340774218687;6144.033909149074;6178.320384757673;6239.937600623981;6258.06129080637;6266.498680105627;5839.795607153772;5856.8535786604825;5857.414258574194;5858.179854820286;5900.675462849542;6262.530310226751;6285.8742825143245;6289.811305660837;6298.212723409574;6300.621962682254;6021.2473440819895;6099.512039036867;6134.4172303631085;6134.417230363198;6145.170401995762;6110.847228819226;6117.694115294306;6156.815295541141;6212.409821066992;6237.906431403532;6137.263528376623;6149.954507733696;6201.658908760061;6218.378162183836;6237.906431403532;6096.708114891155;6117.357677443804;6128.105930682418;6228.937710622927;6231.594946328474;4881.194602890483;4881.707097574086;4885.1206782779445;4913.241370351684;4921.114199444063;3818.446325282874;4439.4006809080365;4444.866654000385;4456.064226512469;4461.130079634505;5577.9959607271085;5666.206731057573;5675.574331925122;5697.0599851024945;5781;4745.83389581363;6189.04069869171;6216.782412615627;6219.657918814509;6238.719257633326;4986.7257300848805;5237.711925844115;5413.079776438015;5722.284714410699;5737.340205876294;4232.090100628318;4764.714117152982;5011.649184557119;5300.761465734051;5362.061639213122;6276.403741644536;6319.146915166578;6343.492520598249;6344.143540622049;6374.968125159345;5159.742012899265;6074.119252708244;6250.781222657185;6253.124562561154;6264.404881536247;6241;6284.3087260402235;6285.182926219562;6287.559870808999;6320.525960553069;6122.724477398617;6125.509959203342;6131.264248290234;6161.4146656067605;6169.167162433194;6132.661461321697;6145.709401025834;6174.8147555573405;6204.875902481835;6217.378262173746;5460.017196904437;5575.1915972184615;5978.461938425563;6068.180795592539;6125.571219981412;6086.665233412028;6096.908546371897;6118.326984031842;6152;6173.197484327009;5829.8631766805065;5843.824685259449;5977.641341519523;5982.880342393215;5998.070299103646;6074.726637301421;6103.176071230327;6107.816765497042;6109.6639684817765;6137.263528376623;5903.439173278532;5959.195508606283;5962.135490353961;5967.880642387041;5970.880582388415 09:51:30 INFO - PROCESS | 1993 | |1;ext.html;418.9958100418997;498.96257780666446;561.0434209672509;563.4365634365635;615.7783198048702;38390.424143637836;39216.411753823646;39219.82340529785;39271.60728392715;39289;40273.99315017118;40686.18627627446;41300.58699413005;41457.7927110364;41516.37725434113;9291.999999999984;9489.28830337724;9496.857547136799;9517.476538790364;9556;9428.387154834949;9554.140127388533;9624.759381015461;9642.566084526177;9674.806503869919;9581.90418095817;9684.370515916478;9687.982761810013;9719.271054670893;9723.805523889518;9579;9596.472194029326;9622.182114520274;9632.27757918159;9686.612535498607;9485.715428537085;9569;9635.518224088768;9639.855402168972;9655.662051828152;39540;39637.40543891844;39823.8008809957;39925.60074399277;39932.80033599842;3068.5243787213017;3081.091078131934;3135.749140068789;3298.6371499135316;3538.258286894938;25803.741962580323;27136.050238241765;28823.279418014507;29023.854880725674;29801;2677.3708178578017;2736.3843135294596;2771.5565509518583;2779.291280723423;2817.4224284021725;378747;390856;476248.61875690747;478169;479924;67768.66115669488;68191.65904170448;68203;68328.3167168322;68404.65797671079;71517;75523.24476755272;76781.61609191919;77158;77228;16744.330226791037;16917.830821691627;16922;17081.48755537336;17090.743638845426;11351.148663850245;12120.81818772719;12527.37363131858;12767.233965962072;12864.421101050475;21740.782592173877;21861.016254268598;22062.88968555147;22199.77800221977;22300.442488937908;9106.635734570675;9345.626174952926;9352.625894964125;9365.297602679826;9378.85931711025;872.3370238618569;928.3919033033374;952.2144231009445;1058.222206678091;1100.5212732461405;29247;29348.853255733586;29911.850440747658;29927.850360748493;30161.69838301589;962.2782912815388;993.7068564773265;1042.0465274273954;1072.5709716113618;1095.2169199022737;11810.291382517076;16048;16354.754678679828;16401.015939043697;16553.420630278124;627405;627670;628999;631311;633675;60679.39320606826;60979.69510152421;62213.377866221665;62711.6864415675;63375.049374259426;1415.356013014076;1483.6513419346445;1483.725510780509;1504.3456096598015;1620.5138458462413;25696.972121114944;27370.178894633194;27980;30819;31446.528302075945;42607.1478570433;42662.78668606637;52169;52229.47770522398;52660.94678106493;346258;423423;426887;490654;493640;33721.1453370067;44111.77944110259;45355.773221135;46010.30984535168;46100.76949615365;43581.78209108934;43775.34336985012;43816;44172.674819755455;44373.33439998338;36458.90623281306;36494.81752591326;36499;36834.07914802151;37321.626783731816;36108.09729756777;36188.09529761777;36974;37841.4323785138;37927.620723793516;32659;37290;37565.4365184517;38120;39110.6088939107;31280.530792037684;31664.525032124075;31908;32063.839680801448;32132.518012229368;24235.75764242335;24493.877530612946;24700;24700.752992470563;25373.492530149662 09:51:30 INFO - PROCESS | 1993 | |2;jquery.html;353.87260586188984;355.3089241425427;364.58619466905066;369.1122849546839;370.28165359203126;19298;19964;21328.146874125017;21352.25267115651;21391.358259252207;11926.284422934608;12053.517859285617;12334.383280835944;12339;12385.814212786816;4876.658633895629;5167.715775632339;5168.198929165986;6005.279366476029;6021.879562408749;5899.469047785698;5916.585838991272;5939.940600594004;5995.340512543617;6011.038233882579;5640.125780504029;5797;5939.406059394069;5941.613795103326;5951.256092988377;4896.290037944496;5802.042662960585;5803.303603567557;5933.317668468117;5965.3736357682255;5170.1986192140275;5221.190715439113;5228.241904923765;5229.738513074331;5235.345581802275;13313.800292995613;13637.249951252677;13729.313534323244;14446.78329825043;24996.3750906227;2082.8125468707735;2120.183729264229;2130.648443006902;2148.301801914384;2196.428928478591;9609.327347085708;9739.853902191473;9994.500274986294;10022.3485473444;10082.19342452602;1703.3442124781925;1711.3240270093368;1731.0392732033715;1737.643783024477;1748.7027205375116;95934;98966;101479.49260253726;102277.9544409115;102423.4878825601;11004.614838480775;11116.666500005012;11194.552217911192;11291.49188286529;11371.715707107389;13496.32518374097;13743;13831.03182777216;13851.16892986424;13862.920561915793;7120.60836653989;7876.17300183484;8230.958845205856;8406.537640429835;8607.698730544402;8419.115992820789;8553.016403113597;8555.914440855637;8619.525926074126;8659.826803463895;4169.728967617095;4368.4321038264825;4373.169097871394;4507.391502147234;4526.59260666535;1582.786323846289;1828.61599064198;1886.1135266424758;1888.9244430222911;1921.1066853912998;882.2765332427476;927.5477707006343;1000.5747557288123;1008.0977525115128;1031.5306535526317;18547.907260463613;19915.10382032812;20007.499812504804;20297.492562685755;20603.86678732654;905.3481493324796;935.8736570563022;951.1629765806047;970;993.1707024634367;7937.484063535851;10794.298370605886;10836.512356943957;10859.674209773719;10942.358646203133;597054;605181;610884;618914;622202;86559;112119;113192.43403783093;114761.4261928685;114770;958.7171784323641;969.5782334684576;988.8912219655832;992.9950350248203;993.2203220471895;18186.81785683926;18199.636007279514;18220.18009189616;18247.361342352953;18655.72016419782;30760.384792304478;37076;39266.42934282597;48393.128549715235;50043.249351260485;68682.65658671675;69373.65313173401;69651.65174174096;69718.65140674467;69865.30134698589;7244.348008679244;7586.24137586237;7616.466847320635;7668.309852113337;7834.1382447929545;10880;11301.547938082385;11906.34515101643;12432.937835310766;12638.810417843924;10010.299279050396;10015.549300281358;10281.897181028095;10390.324628899098;10421.843672344768;9695.466749328572;10337.586496540054;10603.151747860307;10642.680719578426;10743;8019.759407217793;10065.295429319878;10323.741906452398;10516.856625080465;10587.417692027013;6463.353664633499;6598.736050557924;7509.3617042552;7666.501677391175;8110.83778324442;9015.459072455673;10861.67414977552;10892.945535272273;11016.669499915015;11035.282706624044 09:51:30 INFO - PROCESS | 1993 | |3;mootools.html;1585.2390852390852;1588.2376459299535;1876.446448297752;1981.9306324278652;1999.630068437339;7921.287084162424;8678.826423471535;8718.258947989429;8847.247983921374;8865.335099867512;8666.39335246533;8712.215900568948;8718.258947989412;8806.07536208697;8817.95591022044;2400.1119585753295;2415.5531226723024;2425.442148305891;2428.0651948999675;2434.7443518430578;2473.50529894021;2474.34429876083;2495.2763698527406;2516.4967006598754;2519.1812660885194;2475.3687809608523;2488.875556222191;2499;2511.522810665977;2514.421683012908;2407.951840963171;2411.2404592553376;2436.8294219404647;2439.9878000609974;2441.56051910656;2461.396957745346;2483.379155211197;2493.613489909067;2506.912258070977;2520.9243722688348;8853.203211710977;8895.332850036208;8921.821563568692;8951.373403861733;8998.910010899872;5414.648047876875;5484.765927666243;5553.555715542747;5568.969740598002;5569.136783798518;3549.964500355015;3621.0947263184203;3678.503402040744;3685.723570732179;3694.6674799268194;905.8088613473261;953.8950715421298;983.6458874805064;1025.021104844879;1028.2801889651168;11669.183157179;11885.168038237327;11886.821697674543;11891.940540297242;11895.702607434796;4458.5318541553315;4683.718976861399;4849.684770489906;4884.633652476078;4979.57673597741;9045.68340108093;9139.954300228455;9142.451452912846;9216.078392160864;9219.539023048956;4152.979235103866;4514;4711.222648263067;5247.737613119405;5331.520163185254;4411.250087485135;4834.178189707758;4843.273508973612;4862.197737373364;4957.975210123926;3203.567518385035;3705.6664900158576;3723.702103831741;3819.84720611178;3877.0307423144213;995.64654547636;1185.8458400407892;1199.2564609941892;1205.1142410328403;1209.0690168570327;1053.7049626104704;1079.3200283821143;1088.2436706488913;1250.8186312984567;1399.1814788348727;8293.585320733939;8331.50010999342;8355.373346999;8420.915790842135;8466.74599762008;1029.8506716526063;1170.9648710538697;1177.952881884732;1207.6739280394245;1225.2709637765693;6241.906371404341;6252.5935814171935;6274.905876411766;6401.935980640227;6411.935880641227;9438.95280523593;10476.266661333786;10552.050315471492;10712.625058122929;10752.139828813677;10570.841437378445;10712.196585256137;10752.677419677422;10842.349459032483;10872.293300935415;6912.447004239649;7994.36045116401;8271.917280827114;8306.584670766437;8331;8098.311643510132;8137.877931831145;8148.674053037812;8185.467944583821;8205.876911846446;9233.538323083952;9477.52612369365;9509.334346595671;9537.332386732862;9621.701070355692;9779.902200977898;9807.77402824647;9812.460314682761;9946;10040.949795250977;6770.458363330823;7280.417566594554;7491.288327608869;7536.208698086622;7645.61771911391;8167.101618821806;8170.01959764832;8320.16798320163;8321.667133314842;8430.325573953945;7253.528520646141;7326.450516211199;7389.926100738924;7499.550026998398;7513.962430187814;7190.96404517974;7210;7309.671064802203;7332.633368331669;7366.447516436181;6760.661966901734;7777.222277772177;7826.452148349561;7826.7651970440975;7847.803804904923;6614;6805.557638753465;6805.931940680728;6840.3501667341525;6914.896276555956;7061.470389720895;7087.397571206505;7093.645317733989;7136.571805691675;7178.820529486805 09:51:30 INFO - PROCESS | 1993 | |4;prototype.html;319.5733695516485;320.1053056706505;322.8159948829168;325.2697693677694;329.91752061984505;6632.70152843122;6698.330166983299;6760.222574403945;6778.288279730631;6780.559263647871;5403.8108666196695;6218.160548325986;6599.835004124887;6616.239132499764;6683.398494135527;4308.310670292762;4641.443026836768;4691.437027556698;4815.951840481603;4817.638677099231;4784.760761961906;4813.350197723297;4822.059698358804;4825.662203645747;4829.565339119478;3611.3138503684218;4774.2122549779415;4789.688670236441;4797.568218860302;4827.468978412372;3896.9088655176597;4643.373144625483;4803.471618122004;4852.17513022787;4883.218685010417;4143.6892233082635;4155.58444155585;4163.10493243951;4164.354525048622;4181.163767246563;6212.596181248249;6419.165508483914;6440.742370305182;6442.613443193423;6482.41658250755;4694.201985662446;5639.069553523664;5678.744456499468;5681.914771278434;5725.456081672234;7145.821354466128;7154.499185057048;7167.175774785862;7193.208747037822;7205.387542058931;4591.747453890035;4591.9081618367445;4598.0803839232285;4614.607758340545;4615.676902616819;7455.925440745577;7516.098068231792;7528.887066694004;7535.623218839036;7607.16321204667;4448.354988526646;4617.307403889444;4618.745968971672;4638.327442520816;4677.929831052537;4718.268668356411;4725.196716558194;4737.38414006177;4737.8104875805275;4743.407074115736;5683.772649094072;5684.8863022739315;5686.14707793826;5697.7151142443545;5702.401247868914;7208.603526806076;7236.746713864989;7250.891236631454;7255.347018768336;7275.054242948383;1626.4063616780027;1650.9257083431276;1651.596143278204;1652.0913497576284;1655.329591515438;995.930284880066;1034.6275340877278;1046.3042077018697;1047.512906498482;1051.7948999944938;6537.803865884031;6584.572002819801;6603.966980165068;6611.371919667624;6620.470362371095;7412.332890039922;7426.331630153204;7473.925260747432;7474.1404738454685;7523.022007139037;6401.615903045832;6566.474682025427;6672.699728512229;6717.429018533479;6727.629980351127;3969.92060158801;3983.8406463741126;4008.378701301303;4008.5590585035625;4014.4580481634607;6679.833004174934;7848.607569621496;7879.606019698992;7882.684692612346;7891.210878912063;6773.72905083801;6852.040714300002;7194.172670143001;7518.887216691754;7744.92255077442;7805.141434442206;7865.056193256846;7871.17352677972;7881.842363152705;7888.802779930433;6360.950443176824;7213.60325182099;7561.848763024599;7563.584002879895;7569.545827250162;5527.917081243865;7372.447066469929;7383.446241531799;7433.070866141732;7450.8823676448965;7073.681684324115;7592.3697896453805;7711.460197786101;7837.0987336454755;7852.489588176751;4627.583517483308;4643;4668.323093151406;4673.462551806586;4684.0866031123605;7468.477206595486;7475.626218688935;7480.251974802693;7518.436117291334;7520.849583008418;7132.429405647432;7259.854802903807;7266.1280646322775;7302.890456643048;7308.8903666443985;6966.094407726963;7241.782746517613;7248.927510724825;7262.491625586158;7270.927290727025;6682.661068625942;7038.014677945194;7049.118860142482;7075.6815943281645;7112.573245605074;7213.458990575623;7248.746293879689;7249.528780629243;7263.818404539928;7283.089613798275;7070.71717131309;7085.858282834211;7086.929130708627;7096.716131354688;7115.324044215791 09:51:30 INFO - PROCESS | 1993 | |5;yui.html;677.5291172635018;748.8614606297833;750.2197714377048;756.0511557994715;774.856651519469;14284.142951422922;14343.641408964768;14453.566393008201;14455.855441445583;14499.92750036251;13209.075364724473;13247.53633622821;13264.93367533161;13552.39014244359;13754.312284385791;698.5145323999823;884.0982198157875;892.9642814287453;904.3262769236927;904.728581425573;878.4202426398579;890.4746199742151;898.3217670658644;900.1268769293774;901.2699713232303;918.9264858811279;918.9908100918972;919.5126582911067;920.3281604428771;946.6118891254587;911.9316051296146;925.9120383563551;946.957386917587;947.9951251673249;948.6300342866288;684.945204383653;686.0463955102412;687.8108520156946;707.0525495835604;708.5890183693497;13551.864481355158;13563.321833908265;13677.179369237778;13759.449622015107;13778.65553361164;12536.435860386304;12596.307203103826;12617.810732839014;12747.553835615801;12865.549705760348;9794;9879.604815807359;9893.554790034394;9925.156361709263;10268.48657567126;3349.5645566076496;3473.930521389583;3538.097785064818;3540.716742660581;3555.4311310190246;81438.59280703618;81550.59224703838;82544;82580.58709706474;82684.58657706673;7884.566348850868;9433.575489103006;9468.479233642078;9561.521923903778;9663.661771837951;21175.047122879507;21226.575468490853;21796.128154873626;21921.561568768855;22003;7191.316824901626;7339.853202935911;7348.77953661391;7459.738909138154;7489.438292128112;3987.282289187974;4040.4949381327333;4053.9391909120795;4060;4069.369247766601;3481.234128491728;3482.89551313461;3508.8421021054114;3556.28874225156;3563.0914116900026;631.6462780842743;642.4250295985067;651.221789960992;651.4332530698323;655.2988302516262;567.9379560222411;568.8691600931809;576.3113079869515;606.3845197124922;608.2366629879562;8094.959525202336;8095.39284553649;8169.63236654352;8252.546109963889;8307.418480706414;523.2308506495445;578.4360248757428;585.2479563760547;604.9987271066304;610.225014231923;3577.5885773136424;3714.1457464783252;3747.569029561581;3769.26499332633;3814.5231846019246;91443;91912;92172;92928;94198.52900735452;64167;78344.60827695939;78895.21104788994;79463.60268198622;80628.59685701651;69810.3018969814;70059.89820305399;70198;71171;71860.28139718641;6402.423781859655;7545.283198096172;7598.506097103671;7657.4256930731535;7872.685092596461;45373.86565335761;48220.7588962053;48354.51645483641;49178;50206.7489662564;42342.57657423386;61819;63615;63717.681411592646;66276.6686166566;10651.840222396826;10747.408892510986;10755.032047115797;11010.009099181112;11702.473388697359;11983.64049078529;12036.939815300868;12054.216475929037;12215.877841221474;12267.631971040882;11401.885981140082;11420.48607812667;11460.484278207334;11691.649250522498;12209.023278137905;10930.56277748881;11363.147763917905;11381.715457113638;11405.087592992706;11678.591249306573;11267.323960562393;11443.313401195956;11508.13688973347;11516.078713702716;11636.301821890374;9453.475586198687;9527.714168574954;9629;9665.565049572646;9737.318387713076;9466.574004169692;9514.04961982778;9568.856467153137;9586;9633.277504187354 09:51:30 INFO - PROCESS | 1993 | __end_tp_report 09:51:30 INFO - PROCESS | 1993 | __start_cc_report 09:51:30 INFO - PROCESS | 1993 | _x_x_mozilla_cycle_collect,359 09:51:30 INFO - PROCESS | 1993 | __end_cc_report 09:51:30 INFO - PROCESS | 1993 | __startTimestamp1460047890648__endTimestamp 09:51:30 INFO - PROCESS | 1993 | 09:51:30 INFO - PROCESS | 1993 | ------- Summary: start ------- 09:51:30 INFO - PROCESS | 1993 | Number of tests: 6 09:51:30 INFO - PROCESS | 1993 | 09:51:30 INFO - PROCESS | 1993 | [#0] dojo.html Cycles:165 Average:5657.58 Median:5903.44 stddev:689.75 (11.7%) stddev-sans-first:659.85 09:51:30 INFO - PROCESS | 1993 | Values: 3009.6 3088.3 3413.9 3484.9 3514.6 5654.4 5660.1 5680.1 5690.8 5719.5 5550.4 5680.2 5702.4 5808.0 5821.5 5091.8 5137.8 5174.3 5211.0 5213.5 5163.5 5164.3 5171.0 5218.3 5233.2 4795.6 4880.5 5076.0 5179.7 5210.0 5114.9 5149.5 5167.4 5179.1 5208.3 4961.6 5024.4 5136.8 5148.9 5153.2 4163.9 5576.5 5605.2 5626.6 5664.6 5118.6 6141.8 6191.1 6229.4 6278.3 6144.0 6178.3 6239.9 6258.1 6266.5 5839.8 5856.9 5857.4 5858.2 5900.7 6262.5 6285.9 6289.8 6298.2 6300.6 6021.2 6099.5 6134.4 6134.4 6145.2 6110.8 6117.7 6156.8 6212.4 6237.9 6137.3 6150.0 6201.7 6218.4 6237.9 6096.7 6117.4 6128.1 6228.9 6231.6 4881.2 4881.7 4885.1 4913.2 4921.1 3818.4 4439.4 4444.9 4456.1 4461.1 5578.0 5666.2 5675.6 5697.1 5781.0 4745.8 6189.0 6216.8 6219.7 6238.7 4986.7 5237.7 5413.1 5722.3 5737.3 4232.1 4764.7 5011.6 5300.8 5362.1 6276.4 6319.1 6343.5 6344.1 6375.0 5159.7 6074.1 6250.8 6253.1 6264.4 6241.0 6284.3 6285.2 6287.6 6320.5 6122.7 6125.5 6131.3 6161.4 6169.2 6132.7 6145.7 6174.8 6204.9 6217.4 5460.0 5575.2 5978.5 6068.2 6125.6 6086.7 6096.9 6118.3 6152.0 6173.2 5829.9 5843.8 5977.6 5982.9 5998.1 6074.7 6103.2 6107.8 6109.7 6137.3 5903.4 5959.2 5962.1 5967.9 5970.9 09:51:30 INFO - PROCESS | 1993 | 09:51:30 INFO - PROCESS | 1993 | [#1] ext.html Cycles:180 Average:65435.53 Median:39730.60 stddev:136520.30 (343.6%) stddev-sans-first:136816.00 09:51:30 INFO - PROCESS | 1993 | Values: 419.0 499.0 561.0 563.4 615.8 38390.4 39216.4 39219.8 39271.6 39289.0 40274.0 40686.2 41300.6 41457.8 41516.4 9292.0 9489.3 9496.9 9517.5 9556.0 9428.4 9554.1 9624.8 9642.6 9674.8 9581.9 9684.4 9688.0 9719.3 9723.8 9579.0 9596.5 9622.2 9632.3 9686.6 9485.7 9569.0 9635.5 9639.9 9655.7 39540.0 39637.4 39823.8 39925.6 39932.8 3068.5 3081.1 3135.7 3298.6 3538.3 25803.7 27136.1 28823.3 29023.9 29801.0 2677.4 2736.4 2771.6 2779.3 2817.4 378747.0 390856.0 476248.6 478169.0 479924.0 67768.7 68191.7 68203.0 68328.3 68404.7 71517.0 75523.2 76781.6 77158.0 77228.0 16744.3 16917.8 16922.0 17081.5 17090.7 11351.1 12120.8 12527.4 12767.2 12864.4 21740.8 21861.0 22062.9 22199.8 22300.4 9106.6 9345.6 9352.6 9365.3 9378.9 872.3 928.4 952.2 1058.2 1100.5 29247.0 29348.9 29911.9 29927.9 30161.7 962.3 993.7 1042.0 1072.6 1095.2 11810.3 16048.0 16354.8 16401.0 16553.4 627405.0 627670.0 628999.0 631311.0 633675.0 60679.4 60979.7 62213.4 62711.7 63375.0 1415.4 1483.7 1483.7 1504.3 1620.5 25697.0 27370.2 27980.0 30819.0 31446.5 42607.1 42662.8 52169.0 52229.5 52660.9 346258.0 423423.0 426887.0 490654.0 493640.0 33721.1 44111.8 45355.8 46010.3 46100.8 43581.8 43775.3 43816.0 44172.7 44373.3 36458.9 36494.8 36499.0 36834.1 37321.6 36108.1 36188.1 36974.0 37841.4 37927.6 32659.0 37290.0 37565.4 38120.0 39110.6 31280.5 31664.5 31908.0 32063.8 32132.5 24235.8 24493.9 24700.0 24700.8 25373.5 09:51:30 INFO - PROCESS | 1993 | 09:51:30 INFO - PROCESS | 1993 | [#2] jquery.html Cycles:180 Average:32999.64 Median:359.95 stddev:101053.62 (28074.5%) stddev-sans-first:101307.37 09:51:30 INFO - PROCESS | 1993 | Values: 353.9 355.3 364.6 369.1 370.3 19298.0 19964.0 21328.1 21352.3 21391.4 11926.3 12053.5 12334.4 12339.0 12385.8 4876.7 5167.7 5168.2 6005.3 6021.9 5899.5 5916.6 5939.9 5995.3 6011.0 5640.1 5797.0 5939.4 5941.6 5951.3 4896.3 5802.0 5803.3 5933.3 5965.4 5170.2 5221.2 5228.2 5229.7 5235.3 13313.8 13637.2 13729.3 14446.8 24996.4 2082.8 2120.2 2130.6 2148.3 2196.4 9609.3 9739.9 9994.5 10022.3 10082.2 1703.3 1711.3 1731.0 1737.6 1748.7 95934.0 98966.0 101479.5 102278.0 102423.5 11004.6 11116.7 11194.6 11291.5 11371.7 13496.3 13743.0 13831.0 13851.2 13862.9 7120.6 7876.2 8231.0 8406.5 8607.7 8419.1 8553.0 8555.9 8619.5 8659.8 4169.7 4368.4 4373.2 4507.4 4526.6 1582.8 1828.6 1886.1 1888.9 1921.1 882.3 927.5 1000.6 1008.1 1031.5 18547.9 19915.1 20007.5 20297.5 20603.9 905.3 935.9 951.2 970.0 993.2 7937.5 10794.3 10836.5 10859.7 10942.4 597054.0 605181.0 610884.0 618914.0 622202.0 86559.0 112119.0 113192.4 114761.4 114770.0 958.7 969.6 988.9 993.0 993.2 18186.8 18199.6 18220.2 18247.4 18655.7 30760.4 37076.0 39266.4 48393.1 50043.2 68682.7 69373.7 69651.7 69718.7 69865.3 7244.3 7586.2 7616.5 7668.3 7834.1 10880.0 11301.5 11906.3 12432.9 12638.8 10010.3 10015.5 10281.9 10390.3 10421.8 9695.5 10337.6 10603.2 10642.7 10743.0 8019.8 10065.3 10323.7 10516.9 10587.4 6463.4 6598.7 7509.4 7666.5 8110.8 9015.5 10861.7 10892.9 11016.7 11035.3 09:51:30 INFO - PROCESS | 1993 | 09:51:30 INFO - PROCESS | 1993 | [#3] mootools.html Cycles:180 Average:6005.09 Median:5905.52 stddev:3160.69 (53.5%) stddev-sans-first:3152.10 09:51:30 INFO - PROCESS | 1993 | Values: 1585.2 1588.2 1876.4 1981.9 1999.6 7921.3 8678.8 8718.3 8847.2 8865.3 8666.4 8712.2 8718.3 8806.1 8818.0 2400.1 2415.6 2425.4 2428.1 2434.7 2473.5 2474.3 2495.3 2516.5 2519.2 2475.4 2488.9 2499.0 2511.5 2514.4 2408.0 2411.2 2436.8 2440.0 2441.6 2461.4 2483.4 2493.6 2506.9 2520.9 8853.2 8895.3 8921.8 8951.4 8998.9 5414.6 5484.8 5553.6 5569.0 5569.1 3550.0 3621.1 3678.5 3685.7 3694.7 905.8 953.9 983.6 1025.0 1028.3 11669.2 11885.2 11886.8 11891.9 11895.7 4458.5 4683.7 4849.7 4884.6 4979.6 9045.7 9140.0 9142.5 9216.1 9219.5 4153.0 4514.0 4711.2 5247.7 5331.5 4411.3 4834.2 4843.3 4862.2 4958.0 3203.6 3705.7 3723.7 3819.8 3877.0 995.6 1185.8 1199.3 1205.1 1209.1 1053.7 1079.3 1088.2 1250.8 1399.2 8293.6 8331.5 8355.4 8420.9 8466.7 1029.9 1171.0 1178.0 1207.7 1225.3 6241.9 6252.6 6274.9 6401.9 6411.9 9439.0 10476.3 10552.1 10712.6 10752.1 10570.8 10712.2 10752.7 10842.3 10872.3 6912.4 7994.4 8271.9 8306.6 8331.0 8098.3 8137.9 8148.7 8185.5 8205.9 9233.5 9477.5 9509.3 9537.3 9621.7 9779.9 9807.8 9812.5 9946.0 10040.9 6770.5 7280.4 7491.3 7536.2 7645.6 8167.1 8170.0 8320.2 8321.7 8430.3 7253.5 7326.5 7389.9 7499.6 7514.0 7191.0 7210.0 7309.7 7332.6 7366.4 6760.7 7777.2 7826.5 7826.8 7847.8 6614.0 6805.6 6805.9 6840.4 6914.9 7061.5 7087.4 7093.6 7136.6 7178.8 09:51:30 INFO - PROCESS | 1993 | 09:51:30 INFO - PROCESS | 1993 | [#4] prototype.html Cycles:180 Average:5820.20 Median:6618.35 stddev:1904.09 (28.8%) stddev-sans-first:1864.14 09:51:30 INFO - PROCESS | 1993 | Values: 319.6 320.1 322.8 325.3 329.9 6632.7 6698.3 6760.2 6778.3 6780.6 5403.8 6218.2 6599.8 6616.2 6683.4 4308.3 4641.4 4691.4 4816.0 4817.6 4784.8 4813.4 4822.1 4825.7 4829.6 3611.3 4774.2 4789.7 4797.6 4827.5 3896.9 4643.4 4803.5 4852.2 4883.2 4143.7 4155.6 4163.1 4164.4 4181.2 6212.6 6419.2 6440.7 6442.6 6482.4 4694.2 5639.1 5678.7 5681.9 5725.5 7145.8 7154.5 7167.2 7193.2 7205.4 4591.7 4591.9 4598.1 4614.6 4615.7 7455.9 7516.1 7528.9 7535.6 7607.2 4448.4 4617.3 4618.7 4638.3 4677.9 4718.3 4725.2 4737.4 4737.8 4743.4 5683.8 5684.9 5686.1 5697.7 5702.4 7208.6 7236.7 7250.9 7255.3 7275.1 1626.4 1650.9 1651.6 1652.1 1655.3 995.9 1034.6 1046.3 1047.5 1051.8 6537.8 6584.6 6604.0 6611.4 6620.5 7412.3 7426.3 7473.9 7474.1 7523.0 6401.6 6566.5 6672.7 6717.4 6727.6 3969.9 3983.8 4008.4 4008.6 4014.5 6679.8 7848.6 7879.6 7882.7 7891.2 6773.7 6852.0 7194.2 7518.9 7744.9 7805.1 7865.1 7871.2 7881.8 7888.8 6361.0 7213.6 7561.8 7563.6 7569.5 5527.9 7372.4 7383.4 7433.1 7450.9 7073.7 7592.4 7711.5 7837.1 7852.5 4627.6 4643.0 4668.3 4673.5 4684.1 7468.5 7475.6 7480.3 7518.4 7520.8 7132.4 7259.9 7266.1 7302.9 7308.9 6966.1 7241.8 7248.9 7262.5 7270.9 6682.7 7038.0 7049.1 7075.7 7112.6 7213.5 7248.7 7249.5 7263.8 7283.1 7070.7 7085.9 7086.9 7096.7 7115.3 09:51:30 INFO - PROCESS | 1993 | 09:51:30 INFO - PROCESS | 1993 | [#5] yui.html Cycles:180 Average:17935.24 Median:35060.05 stddev:25349.64 (72.3%) stddev-sans-first:25387.63 09:51:30 INFO - PROCESS | 1993 | Values: 677.5 748.9 750.2 756.1 774.9 14284.1 14343.6 14453.6 14455.9 14499.9 13209.1 13247.5 13264.9 13552.4 13754.3 698.5 884.1 893.0 904.3 904.7 878.4 890.5 898.3 900.1 901.3 918.9 919.0 919.5 920.3 946.6 911.9 925.9 947.0 948.0 948.6 684.9 686.0 687.8 707.1 708.6 13551.9 13563.3 13677.2 13759.4 13778.7 12536.4 12596.3 12617.8 12747.6 12865.5 9794.0 9879.6 9893.6 9925.2 10268.5 3349.6 3473.9 3538.1 3540.7 3555.4 81438.6 81550.6 82544.0 82580.6 82684.6 7884.6 9433.6 9468.5 9561.5 9663.7 21175.0 21226.6 21796.1 21921.6 22003.0 7191.3 7339.9 7348.8 7459.7 7489.4 3987.3 4040.5 4053.9 4060.0 4069.4 3481.2 3482.9 3508.8 3556.3 3563.1 631.6 642.4 651.2 651.4 655.3 567.9 568.9 576.3 606.4 608.2 8095.0 8095.4 8169.6 8252.5 8307.4 523.2 578.4 585.2 605.0 610.2 3577.6 3714.1 3747.6 3769.3 3814.5 91443.0 91912.0 92172.0 92928.0 94198.5 64167.0 78344.6 78895.2 79463.6 80628.6 69810.3 70059.9 70198.0 71171.0 71860.3 6402.4 7545.3 7598.5 7657.4 7872.7 45373.9 48220.8 48354.5 49178.0 50206.7 42342.6 61819.0 63615.0 63717.7 66276.7 10651.8 10747.4 10755.0 11010.0 11702.5 11983.6 12036.9 12054.2 12215.9 12267.6 11401.9 11420.5 11460.5 11691.6 12209.0 10930.6 11363.1 11381.7 11405.1 11678.6 11267.3 11443.3 11508.1 11516.1 11636.3 9453.5 9527.7 9629.0 9665.6 9737.3 9466.6 9514.0 9568.9 9586.0 9633.3 09:51:30 INFO - PROCESS | 1993 | -------- Summary: end -------- 09:51:30 INFO - PROCESS | 1993 | 09:51:31 INFO - TEST-INFO | 1993: exit 0 09:51:31 INFO - TEST-OK | dromaeo_css | took 1110804ms 09:51:31 INFO - TEST-START | kraken 09:51:31 INFO - operating with platform_type : mac_ 09:51:31 INFO - Initialising browser for kraken test... 09:51:31 INFO - TEST-INFO | started process 1998 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/tmpUgjf1v/profile http://localhost:57150/getInfo.html) 09:51:33 INFO - PROCESS | 1998 | 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] 09:51:33 INFO - PROCESS | 1998 | __metrics Screen width/height:1600/1200 09:51:33 INFO - PROCESS | 1998 | colorDepth:24 09:51:33 INFO - PROCESS | 1998 | Browser inner width/height: 1024/689 09:51:33 INFO - PROCESS | 1998 | __metrics 09:51:34 ERROR - PROCESS | 1998 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 09:51:34 INFO - TEST-INFO | 1998: exit 0 09:51:34 INFO - Browser initialized. 09:51:34 INFO - Running cycle 1/1 for kraken test... 09:51:34 INFO - TEST-INFO | started process 2001 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/tmpUgjf1v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:51:46 INFO - PROCESS | 2001 | RSS: Main: 247078912 09:51:46 INFO - PROCESS | 2001 | 09:51:49 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:57150/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57150/tests/kraken/driver.html?testName=audio-beat-detection) 09:51:49 INFO - PROCESS | 2001 | RSS: Main: 259887104 09:51:49 INFO - PROCESS | 2001 | 09:51:52 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:57150/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57150/tests/kraken/driver.html?testName=audio-dft) 09:51:53 INFO - PROCESS | 2001 | RSS: Main: 268881920 09:51:53 INFO - PROCESS | 2001 | 09:51:56 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:57150/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57150/tests/kraken/driver.html?testName=audio-fft) 09:51:56 INFO - PROCESS | 2001 | RSS: Main: 271863808 09:51:56 INFO - PROCESS | 2001 | 09:51:59 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:57150/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57150/tests/kraken/driver.html?testName=audio-oscillator) 09:51:59 INFO - PROCESS | 2001 | RSS: Main: 272855040 09:51:59 INFO - PROCESS | 2001 | 09:52:01 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:57150/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57150/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:52:02 INFO - PROCESS | 2001 | RSS: Main: 273371136 09:52:02 INFO - PROCESS | 2001 | 09:52:05 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:57150/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57150/tests/kraken/driver.html?testName=imaging-darkroom) 09:52:05 INFO - PROCESS | 2001 | RSS: Main: 274669568 09:52:05 INFO - PROCESS | 2001 | 09:52:08 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:57150/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57150/tests/kraken/driver.html?testName=imaging-desaturate) 09:52:09 INFO - PROCESS | 2001 | RSS: Main: 274309120 09:52:09 INFO - PROCESS | 2001 | 09:52:12 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:57150/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57150/tests/kraken/driver.html?testName=json-parse-financial) 09:52:12 INFO - PROCESS | 2001 | RSS: Main: 274481152 09:52:12 INFO - PROCESS | 2001 | 09:52:14 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:57150/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57150/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:52:14 INFO - PROCESS | 2001 | RSS: Main: 275169280 09:52:15 INFO - PROCESS | 2001 | 09:52:16 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:57150/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57150/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:52:17 INFO - PROCESS | 2001 | RSS: Main: 274382848 09:52:17 INFO - PROCESS | 2001 | 09:52:19 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:57150/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57150/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:52:20 INFO - PROCESS | 2001 | RSS: Main: 274698240 09:52:20 INFO - PROCESS | 2001 | 09:52:22 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:57150/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57150/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:52:23 INFO - PROCESS | 2001 | RSS: Main: 275009536 09:52:23 INFO - PROCESS | 2001 | 09:52:26 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:57150/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57150/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:52:26 INFO - PROCESS | 2001 | RSS: Main: 274874368 09:52:26 INFO - PROCESS | 2001 | 09:52:28 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:57150/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57150/tests/kraken/driver.html?testName=ai-astar) 09:52:28 INFO - PROCESS | 2001 | RSS: Main: 277114880 09:52:28 INFO - PROCESS | 2001 | 09:52:28 INFO - PROCESS | 2001 | __start_tp_report 09:52:28 INFO - PROCESS | 2001 | _x_x_mozilla_page_load 09:52:28 INFO - PROCESS | 2001 | _x_x_mozilla_page_load_details 09:52:28 INFO - PROCESS | 2001 | |i|pagename|runs| 09:52:28 INFO - PROCESS | 2001 | |0;ai-astar;123;113;115;116;114;127;113;115;97;167 09:52:28 INFO - PROCESS | 2001 | |1;audio-beat-detection;159;125;151;190;151;136;142;141;157;142 09:52:28 INFO - PROCESS | 2001 | |2;audio-dft;192;202;266;206;208;214;198;196;207;203 09:52:28 INFO - PROCESS | 2001 | |3;audio-fft;67;73;96;99;95;125;81;84;81;58 09:52:28 INFO - PROCESS | 2001 | |4;audio-oscillator;83;91;131;94;80;83;118;81;83;117 09:52:28 INFO - PROCESS | 2001 | |5;imaging-gaussian-blur;91;90;91;89;91;85;93;103;83;131 09:52:28 INFO - PROCESS | 2001 | |6;imaging-darkroom;97;98;95;97;97;96;96;114;146;119 09:52:28 INFO - PROCESS | 2001 | |7;imaging-desaturate;92;86;151;146;92;91;93;92;92;96 09:52:28 INFO - PROCESS | 2001 | |8;json-parse-financial;52;53;55;57;58;60;57;66;59;56 09:52:28 INFO - PROCESS | 2001 | |9;json-stringify-tinderbox;67;71;70;72;73;77;71;68;68;67 09:52:28 INFO - PROCESS | 2001 | |10;stanford-crypto-aes;87;87;84;85;88;88;84;88;84;87 09:52:28 INFO - PROCESS | 2001 | |11;stanford-crypto-ccm;142;153;123;126;137;148;130;127;123;123 09:52:28 INFO - PROCESS | 2001 | |12;stanford-crypto-pbkdf2;142;146;181;144;143;132;140;158;181;137 09:52:28 INFO - PROCESS | 2001 | |13;stanford-crypto-sha256-iterative;70;67;67;69;70;67;69;68;65;69 09:52:28 INFO - PROCESS | 2001 | __end_tp_report 09:52:28 INFO - PROCESS | 2001 | __start_cc_report 09:52:28 INFO - PROCESS | 2001 | _x_x_mozilla_cycle_collect,989 09:52:28 INFO - PROCESS | 2001 | __end_cc_report 09:52:28 INFO - PROCESS | 2001 | __startTimestamp1460047948702__endTimestamp 09:52:28 INFO - PROCESS | 2001 | 09:52:28 INFO - PROCESS | 2001 | ------- Summary: start ------- 09:52:28 INFO - PROCESS | 2001 | Number of tests: 14 09:52:28 INFO - PROCESS | 2001 | 09:52:28 INFO - PROCESS | 2001 | [#0] ai-astar Cycles:10 Average:120.00 Median:119.50 stddev:18.25 (15.3%) stddev-sans-first:19.32 09:52:28 INFO - PROCESS | 2001 | Values: 123.0 113.0 115.0 116.0 114.0 127.0 113.0 115.0 97.0 167.0 09:52:28 INFO - PROCESS | 2001 | 09:52:28 INFO - PROCESS | 2001 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:151.00 stddev:17.51 (11.6%) stddev-sans-first:18.22 09:52:28 INFO - PROCESS | 2001 | Values: 159.0 125.0 151.0 190.0 151.0 136.0 142.0 141.0 157.0 142.0 09:52:28 INFO - PROCESS | 2001 | 09:52:28 INFO - PROCESS | 2001 | [#2] audio-dft Cycles:10 Average:209.20 Median:206.50 stddev:20.95 (10.1%) stddev-sans-first:21.28 09:52:28 INFO - PROCESS | 2001 | Values: 192.0 202.0 266.0 206.0 208.0 214.0 198.0 196.0 207.0 203.0 09:52:28 INFO - PROCESS | 2001 | 09:52:28 INFO - PROCESS | 2001 | [#3] audio-fft Cycles:10 Average:85.90 Median:82.50 stddev:18.97 (23.0%) stddev-sans-first:18.85 09:52:28 INFO - PROCESS | 2001 | Values: 67.0 73.0 96.0 99.0 95.0 125.0 81.0 84.0 81.0 58.0 09:52:28 INFO - PROCESS | 2001 | 09:52:28 INFO - PROCESS | 2001 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:83.00 stddev:18.76 (22.6%) stddev-sans-first:19.29 09:52:28 INFO - PROCESS | 2001 | Values: 83.0 91.0 131.0 94.0 80.0 83.0 118.0 81.0 83.0 117.0 09:52:28 INFO - PROCESS | 2001 | 09:52:28 INFO - PROCESS | 2001 | [#5] imaging-gaussian-blur Cycles:10 Average:94.70 Median:90.50 stddev:13.81 (15.3%) stddev-sans-first:14.58 09:52:28 INFO - PROCESS | 2001 | Values: 91.0 90.0 91.0 89.0 91.0 85.0 93.0 103.0 83.0 131.0 09:52:28 INFO - PROCESS | 2001 | 09:52:28 INFO - PROCESS | 2001 | [#6] imaging-darkroom Cycles:10 Average:105.50 Median:96.50 stddev:16.53 (17.1%) stddev-sans-first:17.24 09:52:28 INFO - PROCESS | 2001 | Values: 97.0 98.0 95.0 97.0 97.0 96.0 96.0 114.0 146.0 119.0 09:52:28 INFO - PROCESS | 2001 | 09:52:28 INFO - PROCESS | 2001 | [#7] imaging-desaturate Cycles:10 Average:103.10 Median:92.00 stddev:24.08 (26.2%) stddev-sans-first:25.20 09:52:28 INFO - PROCESS | 2001 | Values: 92.0 86.0 151.0 146.0 92.0 91.0 93.0 92.0 92.0 96.0 09:52:28 INFO - PROCESS | 2001 | 09:52:28 INFO - PROCESS | 2001 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.50 stddev:3.95 (6.9%) stddev-sans-first:3.69 09:52:28 INFO - PROCESS | 2001 | Values: 52.0 53.0 55.0 57.0 58.0 60.0 57.0 66.0 59.0 56.0 09:52:28 INFO - PROCESS | 2001 | 09:52:28 INFO - PROCESS | 2001 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:71.00 stddev:3.13 (4.4%) stddev-sans-first:3.07 09:52:28 INFO - PROCESS | 2001 | Values: 67.0 71.0 70.0 72.0 73.0 77.0 71.0 68.0 68.0 67.0 09:52:28 INFO - PROCESS | 2001 | 09:52:28 INFO - PROCESS | 2001 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:87.00 stddev:1.75 (2.0%) stddev-sans-first:1.83 09:52:28 INFO - PROCESS | 2001 | Values: 87.0 87.0 84.0 85.0 88.0 88.0 84.0 88.0 84.0 87.0 09:52:28 INFO - PROCESS | 2001 | 09:52:28 INFO - PROCESS | 2001 | [#11] stanford-crypto-ccm Cycles:10 Average:133.20 Median:133.50 stddev:11.13 (8.3%) stddev-sans-first:11.34 09:52:28 INFO - PROCESS | 2001 | Values: 142.0 153.0 123.0 126.0 137.0 148.0 130.0 127.0 123.0 123.0 09:52:28 INFO - PROCESS | 2001 | 09:52:28 INFO - PROCESS | 2001 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.40 Median:145.00 stddev:17.46 (12.0%) stddev-sans-first:18.25 09:52:28 INFO - PROCESS | 2001 | Values: 142.0 146.0 181.0 144.0 143.0 132.0 140.0 158.0 181.0 137.0 09:52:28 INFO - PROCESS | 2001 | 09:52:28 INFO - PROCESS | 2001 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:69.00 stddev:1.60 (2.3%) stddev-sans-first:1.54 09:52:28 INFO - PROCESS | 2001 | Values: 70.0 67.0 67.0 69.0 70.0 67.0 69.0 68.0 65.0 69.0 09:52:28 INFO - PROCESS | 2001 | -------- Summary: end -------- 09:52:28 INFO - PROCESS | 2001 | 09:52:29 INFO - TEST-INFO | 2001: exit 0 09:52:29 INFO - TEST-OK | kraken | took 58191ms 09:52:29 INFO - SUITE-END | took 1168s 09:52:29 INFO - Completed test suite (00:19:29) 09:52:29 INFO - javascript benchmark 09:52:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3009.6388433387997, 3088.3360077583316, 3413.9146521336966, 3484.9477257841136, 3514.5782506099263, 5654.434556544344, 5660.094384898417, 5680.11958146488, 5690.829275121742, 5719.513841323487, 5550.4449555044475, 5680.233168522248, 5702.372738998707, 5808.04167312394, 5821.53427725782, 5091.770870310845, 5137.7944882204665, 5174.327337446146, 5211.0, 5213.530782229599, 5163.483651634844, 5164.2770012198325, 5170.974145129269, 5218.347706536683, 5233.2150177473495, 4795.592374648177, 4880.536349046835, 5076.0, 5179.689218646893, 5209.973950130263, 5114.948850511521, 5149.538117755042, 5167.354080739908, 5179.067767801795, 5208.348956380452, 4961.603071754251, 5024.397072351305, 5136.794528218867, 5148.897022059537, 5153.201253805666, 4163.895902602429, 5576.470235327637, 5605.243292155547, 5626.634268772516, 5664.631798933097, 5118.61610379223, 6141.802348542036, 6191.133241346215, 6229.439350458435, 6278.340774218687, 6144.033909149074, 6178.320384757673, 6239.937600623981, 6258.06129080637, 6266.498680105627, 5839.795607153772, 5856.8535786604825, 5857.414258574194, 5858.179854820286, 5900.675462849542, 6262.530310226751, 6285.8742825143245, 6289.811305660837, 6298.212723409574, 6300.621962682254, 6021.2473440819895, 6099.512039036867, 6134.4172303631085, 6134.417230363198, 6145.170401995762, 6110.847228819226, 6117.694115294306, 6156.815295541141, 6212.409821066992, 6237.906431403532, 6137.263528376623, 6149.954507733696, 6201.658908760061, 6218.378162183836, 6237.906431403532, 6096.708114891155, 6117.357677443804, 6128.105930682418, 6228.937710622927, 6231.594946328474, 4881.194602890483, 4881.707097574086, 4885.1206782779445, 4913.241370351684, 4921.114199444063, 3818.446325282874, 4439.4006809080365, 4444.866654000385, 4456.064226512469, 4461.130079634505, 5577.9959607271085, 5666.206731057573, 5675.574331925122, 5697.0599851024945, 5781.0, 4745.83389581363, 6189.04069869171, 6216.782412615627, 6219.657918814509, 6238.719257633326, 4986.7257300848805, 5237.711925844115, 5413.079776438015, 5722.284714410699, 5737.340205876294, 4232.090100628318, 4764.714117152982, 5011.649184557119, 5300.761465734051, 5362.061639213122, 6276.403741644536, 6319.146915166578, 6343.492520598249, 6344.143540622049, 6374.968125159345, 5159.742012899265, 6074.119252708244, 6250.781222657185, 6253.124562561154, 6264.404881536247, 6241.0, 6284.3087260402235, 6285.182926219562, 6287.559870808999, 6320.525960553069, 6122.724477398617, 6125.509959203342, 6131.264248290234, 6161.4146656067605, 6169.167162433194, 6132.661461321697, 6145.709401025834, 6174.8147555573405, 6204.875902481835, 6217.378262173746, 5460.017196904437, 5575.1915972184615, 5978.461938425563, 6068.180795592539, 6125.571219981412, 6086.665233412028, 6096.908546371897, 6118.326984031842, 6152.0, 6173.197484327009, 5829.8631766805065, 5843.824685259449, 5977.641341519523, 5982.880342393215, 5998.070299103646, 6074.726637301421, 6103.176071230327, 6107.816765497042, 6109.6639684817765, 6137.263528376623, 5903.439173278532, 5959.195508606283, 5962.135490353961, 5967.880642387041, 5970.880582388415], "unit": "score", "name": "dojo.html", "value": 5613.233303977431}, {"lowerIsBetter": false, "replicates": [418.9958100418997, 498.96257780666446, 561.0434209672509, 563.4365634365635, 615.7783198048702, 38390.424143637836, 39216.411753823646, 39219.82340529785, 39271.60728392715, 39289.0, 40273.99315017118, 40686.18627627446, 41300.58699413005, 41457.7927110364, 41516.37725434113, 9291.999999999984, 9489.28830337724, 9496.857547136799, 9517.476538790364, 9556.0, 9428.387154834949, 9554.140127388533, 9624.759381015461, 9642.566084526177, 9674.806503869919, 9581.90418095817, 9684.370515916478, 9687.982761810013, 9719.271054670893, 9723.805523889518, 9579.0, 9596.472194029326, 9622.182114520274, 9632.27757918159, 9686.612535498607, 9485.715428537085, 9569.0, 9635.518224088768, 9639.855402168972, 9655.662051828152, 39540.0, 39637.40543891844, 39823.8008809957, 39925.60074399277, 39932.80033599842, 3068.5243787213017, 3081.091078131934, 3135.749140068789, 3298.6371499135316, 3538.258286894938, 25803.741962580323, 27136.050238241765, 28823.279418014507, 29023.854880725674, 29801.0, 2677.3708178578017, 2736.3843135294596, 2771.5565509518583, 2779.291280723423, 2817.4224284021725, 378747.0, 390856.0, 476248.61875690747, 478169.0, 479924.0, 67768.66115669488, 68191.65904170448, 68203.0, 68328.3167168322, 68404.65797671079, 71517.0, 75523.24476755272, 76781.61609191919, 77158.0, 77228.0, 16744.330226791037, 16917.830821691627, 16922.0, 17081.48755537336, 17090.743638845426, 11351.148663850245, 12120.81818772719, 12527.37363131858, 12767.233965962072, 12864.421101050475, 21740.782592173877, 21861.016254268598, 22062.88968555147, 22199.77800221977, 22300.442488937908, 9106.635734570675, 9345.626174952926, 9352.625894964125, 9365.297602679826, 9378.85931711025, 872.3370238618569, 928.3919033033374, 952.2144231009445, 1058.222206678091, 1100.5212732461405, 29247.0, 29348.853255733586, 29911.850440747658, 29927.850360748493, 30161.69838301589, 962.2782912815388, 993.7068564773265, 1042.0465274273954, 1072.5709716113618, 1095.2169199022737, 11810.291382517076, 16048.0, 16354.754678679828, 16401.015939043697, 16553.420630278124, 627405.0, 627670.0, 628999.0, 631311.0, 633675.0, 60679.39320606826, 60979.69510152421, 62213.377866221665, 62711.6864415675, 63375.049374259426, 1415.356013014076, 1483.6513419346445, 1483.725510780509, 1504.3456096598015, 1620.5138458462413, 25696.972121114944, 27370.178894633194, 27980.0, 30819.0, 31446.528302075945, 42607.1478570433, 42662.78668606637, 52169.0, 52229.47770522398, 52660.94678106493, 346258.0, 423423.0, 426887.0, 490654.0, 493640.0, 33721.1453370067, 44111.77944110259, 45355.773221135, 46010.30984535168, 46100.76949615365, 43581.78209108934, 43775.34336985012, 43816.0, 44172.674819755455, 44373.33439998338, 36458.90623281306, 36494.81752591326, 36499.0, 36834.07914802151, 37321.626783731816, 36108.09729756777, 36188.09529761777, 36974.0, 37841.4323785138, 37927.620723793516, 32659.0, 37290.0, 37565.4365184517, 38120.0, 39110.6088939107, 31280.530792037684, 31664.525032124075, 31908.0, 32063.839680801448, 32132.518012229368, 24235.75764242335, 24493.877530612946, 24700.0, 24700.752992470563, 25373.492530149662], "unit": "score", "name": "ext.html", "value": 20105.94900066835}, {"lowerIsBetter": false, "replicates": [353.87260586188984, 355.3089241425427, 364.58619466905066, 369.1122849546839, 370.28165359203126, 19298.0, 19964.0, 21328.146874125017, 21352.25267115651, 21391.358259252207, 11926.284422934608, 12053.517859285617, 12334.383280835944, 12339.0, 12385.814212786816, 4876.658633895629, 5167.715775632339, 5168.198929165986, 6005.279366476029, 6021.879562408749, 5899.469047785698, 5916.585838991272, 5939.940600594004, 5995.340512543617, 6011.038233882579, 5640.125780504029, 5797.0, 5939.406059394069, 5941.613795103326, 5951.256092988377, 4896.290037944496, 5802.042662960585, 5803.303603567557, 5933.317668468117, 5965.3736357682255, 5170.1986192140275, 5221.190715439113, 5228.241904923765, 5229.738513074331, 5235.345581802275, 13313.800292995613, 13637.249951252677, 13729.313534323244, 14446.78329825043, 24996.3750906227, 2082.8125468707735, 2120.183729264229, 2130.648443006902, 2148.301801914384, 2196.428928478591, 9609.327347085708, 9739.853902191473, 9994.500274986294, 10022.3485473444, 10082.19342452602, 1703.3442124781925, 1711.3240270093368, 1731.0392732033715, 1737.643783024477, 1748.7027205375116, 95934.0, 98966.0, 101479.49260253726, 102277.9544409115, 102423.4878825601, 11004.614838480775, 11116.666500005012, 11194.552217911192, 11291.49188286529, 11371.715707107389, 13496.32518374097, 13743.0, 13831.03182777216, 13851.16892986424, 13862.920561915793, 7120.60836653989, 7876.17300183484, 8230.958845205856, 8406.537640429835, 8607.698730544402, 8419.115992820789, 8553.016403113597, 8555.914440855637, 8619.525926074126, 8659.826803463895, 4169.728967617095, 4368.4321038264825, 4373.169097871394, 4507.391502147234, 4526.59260666535, 1582.786323846289, 1828.61599064198, 1886.1135266424758, 1888.9244430222911, 1921.1066853912998, 882.2765332427476, 927.5477707006343, 1000.5747557288123, 1008.0977525115128, 1031.5306535526317, 18547.907260463613, 19915.10382032812, 20007.499812504804, 20297.492562685755, 20603.86678732654, 905.3481493324796, 935.8736570563022, 951.1629765806047, 970.0, 993.1707024634367, 7937.484063535851, 10794.298370605886, 10836.512356943957, 10859.674209773719, 10942.358646203133, 597054.0, 605181.0, 610884.0, 618914.0, 622202.0, 86559.0, 112119.0, 113192.43403783093, 114761.4261928685, 114770.0, 958.7171784323641, 969.5782334684576, 988.8912219655832, 992.9950350248203, 993.2203220471895, 18186.81785683926, 18199.636007279514, 18220.18009189616, 18247.361342352953, 18655.72016419782, 30760.384792304478, 37076.0, 39266.42934282597, 48393.128549715235, 50043.249351260485, 68682.65658671675, 69373.65313173401, 69651.65174174096, 69718.65140674467, 69865.30134698589, 7244.348008679244, 7586.24137586237, 7616.466847320635, 7668.309852113337, 7834.1382447929545, 10880.0, 11301.547938082385, 11906.34515101643, 12432.937835310766, 12638.810417843924, 10010.299279050396, 10015.549300281358, 10281.897181028095, 10390.324628899098, 10421.843672344768, 9695.466749328572, 10337.586496540054, 10603.151747860307, 10642.680719578426, 10743.0, 8019.759407217793, 10065.295429319878, 10323.741906452398, 10516.856625080465, 10587.417692027013, 6463.353664633499, 6598.736050557924, 7509.3617042552, 7666.501677391175, 8110.83778324442, 9015.459072455673, 10861.67414977552, 10892.945535272273, 11016.669499915015, 11035.282706624044], "unit": "score", "name": "jquery.html", "value": 8842.598853290929}, {"lowerIsBetter": false, "replicates": [1585.2390852390852, 1588.2376459299535, 1876.446448297752, 1981.9306324278652, 1999.630068437339, 7921.287084162424, 8678.826423471535, 8718.258947989429, 8847.247983921374, 8865.335099867512, 8666.39335246533, 8712.215900568948, 8718.258947989412, 8806.07536208697, 8817.95591022044, 2400.1119585753295, 2415.5531226723024, 2425.442148305891, 2428.0651948999675, 2434.7443518430578, 2473.50529894021, 2474.34429876083, 2495.2763698527406, 2516.4967006598754, 2519.1812660885194, 2475.3687809608523, 2488.875556222191, 2499.0, 2511.522810665977, 2514.421683012908, 2407.951840963171, 2411.2404592553376, 2436.8294219404647, 2439.9878000609974, 2441.56051910656, 2461.396957745346, 2483.379155211197, 2493.613489909067, 2506.912258070977, 2520.9243722688348, 8853.203211710977, 8895.332850036208, 8921.821563568692, 8951.373403861733, 8998.910010899872, 5414.648047876875, 5484.765927666243, 5553.555715542747, 5568.969740598002, 5569.136783798518, 3549.964500355015, 3621.0947263184203, 3678.503402040744, 3685.723570732179, 3694.6674799268194, 905.8088613473261, 953.8950715421298, 983.6458874805064, 1025.021104844879, 1028.2801889651168, 11669.183157179, 11885.168038237327, 11886.821697674543, 11891.940540297242, 11895.702607434796, 4458.5318541553315, 4683.718976861399, 4849.684770489906, 4884.633652476078, 4979.57673597741, 9045.68340108093, 9139.954300228455, 9142.451452912846, 9216.078392160864, 9219.539023048956, 4152.979235103866, 4514.0, 4711.222648263067, 5247.737613119405, 5331.520163185254, 4411.250087485135, 4834.178189707758, 4843.273508973612, 4862.197737373364, 4957.975210123926, 3203.567518385035, 3705.6664900158576, 3723.702103831741, 3819.84720611178, 3877.0307423144213, 995.64654547636, 1185.8458400407892, 1199.2564609941892, 1205.1142410328403, 1209.0690168570327, 1053.7049626104704, 1079.3200283821143, 1088.2436706488913, 1250.8186312984567, 1399.1814788348727, 8293.585320733939, 8331.50010999342, 8355.373346999, 8420.915790842135, 8466.74599762008, 1029.8506716526063, 1170.9648710538697, 1177.952881884732, 1207.6739280394245, 1225.2709637765693, 6241.906371404341, 6252.5935814171935, 6274.905876411766, 6401.935980640227, 6411.935880641227, 9438.95280523593, 10476.266661333786, 10552.050315471492, 10712.625058122929, 10752.139828813677, 10570.841437378445, 10712.196585256137, 10752.677419677422, 10842.349459032483, 10872.293300935415, 6912.447004239649, 7994.36045116401, 8271.917280827114, 8306.584670766437, 8331.0, 8098.311643510132, 8137.877931831145, 8148.674053037812, 8185.467944583821, 8205.876911846446, 9233.538323083952, 9477.52612369365, 9509.334346595671, 9537.332386732862, 9621.701070355692, 9779.902200977898, 9807.77402824647, 9812.460314682761, 9946.0, 10040.949795250977, 6770.458363330823, 7280.417566594554, 7491.288327608869, 7536.208698086622, 7645.61771911391, 8167.101618821806, 8170.01959764832, 8320.16798320163, 8321.667133314842, 8430.325573953945, 7253.528520646141, 7326.450516211199, 7389.926100738924, 7499.550026998398, 7513.962430187814, 7190.96404517974, 7210.0, 7309.671064802203, 7332.633368331669, 7366.447516436181, 6760.661966901734, 7777.222277772177, 7826.452148349561, 7826.7651970440975, 7847.803804904923, 6614.0, 6805.557638753465, 6805.931940680728, 6840.3501667341525, 6914.896276555956, 7061.470389720895, 7087.397571206505, 7093.645317733989, 7136.571805691675, 7178.820529486805], "unit": "score", "name": "mootools.html", "value": 4889.434435842282}, {"lowerIsBetter": false, "replicates": [319.5733695516485, 320.1053056706505, 322.8159948829168, 325.2697693677694, 329.91752061984505, 6632.70152843122, 6698.330166983299, 6760.222574403945, 6778.288279730631, 6780.559263647871, 5403.8108666196695, 6218.160548325986, 6599.835004124887, 6616.239132499764, 6683.398494135527, 4308.310670292762, 4641.443026836768, 4691.437027556698, 4815.951840481603, 4817.638677099231, 4784.760761961906, 4813.350197723297, 4822.059698358804, 4825.662203645747, 4829.565339119478, 3611.3138503684218, 4774.2122549779415, 4789.688670236441, 4797.568218860302, 4827.468978412372, 3896.9088655176597, 4643.373144625483, 4803.471618122004, 4852.17513022787, 4883.218685010417, 4143.6892233082635, 4155.58444155585, 4163.10493243951, 4164.354525048622, 4181.163767246563, 6212.596181248249, 6419.165508483914, 6440.742370305182, 6442.613443193423, 6482.41658250755, 4694.201985662446, 5639.069553523664, 5678.744456499468, 5681.914771278434, 5725.456081672234, 7145.821354466128, 7154.499185057048, 7167.175774785862, 7193.208747037822, 7205.387542058931, 4591.747453890035, 4591.9081618367445, 4598.0803839232285, 4614.607758340545, 4615.676902616819, 7455.925440745577, 7516.098068231792, 7528.887066694004, 7535.623218839036, 7607.16321204667, 4448.354988526646, 4617.307403889444, 4618.745968971672, 4638.327442520816, 4677.929831052537, 4718.268668356411, 4725.196716558194, 4737.38414006177, 4737.8104875805275, 4743.407074115736, 5683.772649094072, 5684.8863022739315, 5686.14707793826, 5697.7151142443545, 5702.401247868914, 7208.603526806076, 7236.746713864989, 7250.891236631454, 7255.347018768336, 7275.054242948383, 1626.4063616780027, 1650.9257083431276, 1651.596143278204, 1652.0913497576284, 1655.329591515438, 995.930284880066, 1034.6275340877278, 1046.3042077018697, 1047.512906498482, 1051.7948999944938, 6537.803865884031, 6584.572002819801, 6603.966980165068, 6611.371919667624, 6620.470362371095, 7412.332890039922, 7426.331630153204, 7473.925260747432, 7474.1404738454685, 7523.022007139037, 6401.615903045832, 6566.474682025427, 6672.699728512229, 6717.429018533479, 6727.629980351127, 3969.92060158801, 3983.8406463741126, 4008.378701301303, 4008.5590585035625, 4014.4580481634607, 6679.833004174934, 7848.607569621496, 7879.606019698992, 7882.684692612346, 7891.210878912063, 6773.72905083801, 6852.040714300002, 7194.172670143001, 7518.887216691754, 7744.92255077442, 7805.141434442206, 7865.056193256846, 7871.17352677972, 7881.842363152705, 7888.802779930433, 6360.950443176824, 7213.60325182099, 7561.848763024599, 7563.584002879895, 7569.545827250162, 5527.917081243865, 7372.447066469929, 7383.446241531799, 7433.070866141732, 7450.8823676448965, 7073.681684324115, 7592.3697896453805, 7711.460197786101, 7837.0987336454755, 7852.489588176751, 4627.583517483308, 4643.0, 4668.323093151406, 4673.462551806586, 4684.0866031123605, 7468.477206595486, 7475.626218688935, 7480.251974802693, 7518.436117291334, 7520.849583008418, 7132.429405647432, 7259.854802903807, 7266.1280646322775, 7302.890456643048, 7308.8903666443985, 6966.094407726963, 7241.782746517613, 7248.927510724825, 7262.491625586158, 7270.927290727025, 6682.661068625942, 7038.014677945194, 7049.118860142482, 7075.6815943281645, 7112.573245605074, 7213.458990575623, 7248.746293879689, 7249.528780629243, 7263.818404539928, 7283.089613798275, 7070.71717131309, 7085.858282834211, 7086.929130708627, 7096.716131354688, 7115.324044215791], "unit": "score", "name": "prototype.html", "value": 5179.507509361394}, {"lowerIsBetter": false, "replicates": [677.5291172635018, 748.8614606297833, 750.2197714377048, 756.0511557994715, 774.856651519469, 14284.142951422922, 14343.641408964768, 14453.566393008201, 14455.855441445583, 14499.92750036251, 13209.075364724473, 13247.53633622821, 13264.93367533161, 13552.39014244359, 13754.312284385791, 698.5145323999823, 884.0982198157875, 892.9642814287453, 904.3262769236927, 904.728581425573, 878.4202426398579, 890.4746199742151, 898.3217670658644, 900.1268769293774, 901.2699713232303, 918.9264858811279, 918.9908100918972, 919.5126582911067, 920.3281604428771, 946.6118891254587, 911.9316051296146, 925.9120383563551, 946.957386917587, 947.9951251673249, 948.6300342866288, 684.945204383653, 686.0463955102412, 687.8108520156946, 707.0525495835604, 708.5890183693497, 13551.864481355158, 13563.321833908265, 13677.179369237778, 13759.449622015107, 13778.65553361164, 12536.435860386304, 12596.307203103826, 12617.810732839014, 12747.553835615801, 12865.549705760348, 9794.0, 9879.604815807359, 9893.554790034394, 9925.156361709263, 10268.48657567126, 3349.5645566076496, 3473.930521389583, 3538.097785064818, 3540.716742660581, 3555.4311310190246, 81438.59280703618, 81550.59224703838, 82544.0, 82580.58709706474, 82684.58657706673, 7884.566348850868, 9433.575489103006, 9468.479233642078, 9561.521923903778, 9663.661771837951, 21175.047122879507, 21226.575468490853, 21796.128154873626, 21921.561568768855, 22003.0, 7191.316824901626, 7339.853202935911, 7348.77953661391, 7459.738909138154, 7489.438292128112, 3987.282289187974, 4040.4949381327333, 4053.9391909120795, 4060.0, 4069.369247766601, 3481.234128491728, 3482.89551313461, 3508.8421021054114, 3556.28874225156, 3563.0914116900026, 631.6462780842743, 642.4250295985067, 651.221789960992, 651.4332530698323, 655.2988302516262, 567.9379560222411, 568.8691600931809, 576.3113079869515, 606.3845197124922, 608.2366629879562, 8094.959525202336, 8095.39284553649, 8169.63236654352, 8252.546109963889, 8307.418480706414, 523.2308506495445, 578.4360248757428, 585.2479563760547, 604.9987271066304, 610.225014231923, 3577.5885773136424, 3714.1457464783252, 3747.569029561581, 3769.26499332633, 3814.5231846019246, 91443.0, 91912.0, 92172.0, 92928.0, 94198.52900735452, 64167.0, 78344.60827695939, 78895.21104788994, 79463.60268198622, 80628.59685701651, 69810.3018969814, 70059.89820305399, 70198.0, 71171.0, 71860.28139718641, 6402.423781859655, 7545.283198096172, 7598.506097103671, 7657.4256930731535, 7872.685092596461, 45373.86565335761, 48220.7588962053, 48354.51645483641, 49178.0, 50206.7489662564, 42342.57657423386, 61819.0, 63615.0, 63717.681411592646, 66276.6686166566, 10651.840222396826, 10747.408892510986, 10755.032047115797, 11010.009099181112, 11702.473388697359, 11983.64049078529, 12036.939815300868, 12054.216475929037, 12215.877841221474, 12267.631971040882, 11401.885981140082, 11420.48607812667, 11460.484278207334, 11691.649250522498, 12209.023278137905, 10930.56277748881, 11363.147763917905, 11381.715457113638, 11405.087592992706, 11678.591249306573, 11267.323960562393, 11443.313401195956, 11508.13688973347, 11516.078713702716, 11636.301821890374, 9453.475586198687, 9527.714168574954, 9629.0, 9665.565049572646, 9737.318387713076, 9466.574004169692, 9514.04961982778, 9568.856467153137, 9586.0, 9633.277504187354], "unit": "score", "name": "yui.html", "value": 6793.7277296397215}], "name": "dromaeo_css", "value": 7455.349316826055}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [123.0, 113.0, 115.0, 116.0, 114.0, 127.0, 113.0, 115.0, 97.0, 167.0], "unit": "score", "name": "ai-astar", "value": 120.0}, {"lowerIsBetter": true, "replicates": [159.0, 125.0, 151.0, 190.0, 151.0, 136.0, 142.0, 141.0, 157.0, 142.0], "unit": "score", "name": "audio-beat-detection", "value": 149.4}, {"lowerIsBetter": true, "replicates": [192.0, 202.0, 266.0, 206.0, 208.0, 214.0, 198.0, 196.0, 207.0, 203.0], "unit": "score", "name": "audio-dft", "value": 209.2}, {"lowerIsBetter": true, "replicates": [67.0, 73.0, 96.0, 99.0, 95.0, 125.0, 81.0, 84.0, 81.0, 58.0], "unit": "score", "name": "audio-fft", "value": 85.9}, {"lowerIsBetter": true, "replicates": [83.0, 91.0, 131.0, 94.0, 80.0, 83.0, 118.0, 81.0, 83.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 96.1}, {"lowerIsBetter": true, "replicates": [91.0, 90.0, 91.0, 89.0, 91.0, 85.0, 93.0, 103.0, 83.0, 131.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 94.7}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 95.0, 97.0, 97.0, 96.0, 96.0, 114.0, 146.0, 119.0], "unit": "score", "name": "imaging-darkroom", "value": 105.5}, {"lowerIsBetter": true, "replicates": [92.0, 86.0, 151.0, 146.0, 92.0, 91.0, 93.0, 92.0, 92.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 103.1}, {"lowerIsBetter": true, "replicates": [52.0, 53.0, 55.0, 57.0, 58.0, 60.0, 57.0, 66.0, 59.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [67.0, 71.0, 70.0, 72.0, 73.0, 77.0, 71.0, 68.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.4}, {"lowerIsBetter": true, "replicates": [87.0, 87.0, 84.0, 85.0, 88.0, 88.0, 84.0, 88.0, 84.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.2}, {"lowerIsBetter": true, "replicates": [142.0, 153.0, 123.0, 126.0, 137.0, 148.0, 130.0, 127.0, 123.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 133.2}, {"lowerIsBetter": true, "replicates": [142.0, 146.0, 181.0, 144.0, 143.0, 132.0, 140.0, 158.0, 181.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.4}, {"lowerIsBetter": true, "replicates": [70.0, 67.0, 67.0, 69.0, 70.0, 67.0, 69.0, 68.0, 65.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1529.5000000000002}]} 09:52:29 INFO - Return code: 0 09:52:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:52:29 ERROR - # TBPL SUCCESS # 09:52:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:52:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:52:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:52:29 INFO - 2016-04-07 09:52:29.548 screenresolution[2006:21577] starting screenresolution argv=screenresolution get 09:52:29 INFO - 2016-04-07 09:52:29.552 screenresolution[2006:21577] Display 0: 1600x1200x32@60 09:52:29 INFO - 2016-04-07 09:52:29.559 screenresolution[2007:21580] starting screenresolution argv=screenresolution list 09:52:29 INFO - Available Modes on Display 0 09:52:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:52:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:52:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:52:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:52:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:52:29 INFO - Intel Iris: 09:52:29 INFO - Chipset Model: Intel Iris 09:52:29 INFO - Type: GPU 09:52:29 INFO - Bus: Built-In 09:52:29 INFO - VRAM (Dynamic, Max): 1536 MB 09:52:29 INFO - Vendor: Intel (0x8086) 09:52:29 INFO - Device ID: 0x0a2e 09:52:29 INFO - Revision ID: 0x0009 09:52:29 INFO - Displays: 09:52:29 INFO - Display: 09:52:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:52:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:52:29 INFO - Display Serial Number: 1600x1200 60 09:52:29 INFO - Main Display: Yes 09:52:29 INFO - Mirror: Off 09:52:29 INFO - Online: Yes 09:52:29 INFO - Rotation: Supported 09:52:29 INFO - Return code: 0 09:52:29 INFO - Running post-action listener: _resource_record_post_action 09:52:29 INFO - Running post-run listener: _resource_record_post_run 09:52:30 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 978944; Write bytes: 695952896; Read time: 8; Write time: 2567 09:52:30 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 385847808; Write bytes: 379446784; Read time: 28965; Write time: 686 09:52:30 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 978944; Write bytes: 301137920; Read time: 8; Write time: 1836 09:52:30 INFO - Running post-run listener: _upload_blobber_files 09:52:30 INFO - Blob upload gear active. 09:52:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:52:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:52:30 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:52:30 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:52:31 INFO - (blobuploader) - INFO - Open directory for files ... 09:52:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:52:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:52:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:52:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:52:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:52:32 INFO - (blobuploader) - INFO - Done attempting. 09:52:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:52:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:52:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:52:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:52:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:52:33 INFO - (blobuploader) - INFO - Done attempting. 09:52:33 INFO - (blobuploader) - INFO - Iteration through files over. 09:52:33 INFO - Return code: 0 09:52:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:52:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:52:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1257a59a363049587843c409e0e48c93aae0f92c18c8e30b6e65a305aa9c4f971dd7cc949fdd9f259d004828da92abe30ce68c806d9f56d2911f5b12f0e6f75", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a65b85135973966fbed3171421605147f08d27b133f2c61f9a7e1e06c3fd62e17325245240a196e9579b7290fbe47f78d5ae522c098ccc10363d9bbfc0f8cfd0"} 09:52:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:52:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:52:33 INFO - Contents: 09:52:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1257a59a363049587843c409e0e48c93aae0f92c18c8e30b6e65a305aa9c4f971dd7cc949fdd9f259d004828da92abe30ce68c806d9f56d2911f5b12f0e6f75", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a65b85135973966fbed3171421605147f08d27b133f2c61f9a7e1e06c3fd62e17325245240a196e9579b7290fbe47f78d5ae522c098ccc10363d9bbfc0f8cfd0"} 09:52:33 INFO - Running post-run listener: copy_logs_to_upload_dir 09:52:33 INFO - Copying logs to upload dir... 09:52:33 INFO - mkdir: /builds/slave/test/build/upload/logs 09:52:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.774223 ========= master_lag: 9.25 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-07 09:52:41.791373) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 29 secs) (at 2016-04-07 09:52:41.795083) ========= 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.yHYrppqM6R/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.D2cEOcTxq3/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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/Fx-Team/sha512/e1257a59a363049587843c409e0e48c93aae0f92c18c8e30b6e65a305aa9c4f971dd7cc949fdd9f259d004828da92abe30ce68c806d9f56d2911f5b12f0e6f75", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a65b85135973966fbed3171421605147f08d27b133f2c61f9a7e1e06c3fd62e17325245240a196e9579b7290fbe47f78d5ae522c098ccc10363d9bbfc0f8cfd0"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459966130/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011691 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459966130/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1257a59a363049587843c409e0e48c93aae0f92c18c8e30b6e65a305aa9c4f971dd7cc949fdd9f259d004828da92abe30ce68c806d9f56d2911f5b12f0e6f75", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a65b85135973966fbed3171421605147f08d27b133f2c61f9a7e1e06c3fd62e17325245240a196e9579b7290fbe47f78d5ae522c098ccc10363d9bbfc0f8cfd0"}' ========= master_lag: 29.38 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 29 secs) (at 2016-04-07 09:53:11.183641) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-04-07 09:53:11.192098) ========= 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.yHYrppqM6R/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.D2cEOcTxq3/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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.005169 ========= master_lag: 2.16 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-04-07 09:53:13.355102) ========= ========= Started reboot skipped (results: 3, elapsed: 8 secs) (at 2016-04-07 09:53:13.355396) ========= ========= Finished reboot skipped (results: 3, elapsed: 8 secs) (at 2016-04-07 09:53:22.223614) ========= ========= Total master_lag: 96.18 =========