builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0071 starttime: 1460046582.8 results: success (0) buildid: 20160407091419 builduid: 11711c41b894477bbe8e36a386a7f8be revision: 1725b460c3e0de97590cb8764df9ace9115b813e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 09:29:42.801570) ========= 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:42.802001) ========= ========= Started set props: basedir (results: 0, elapsed: 10 secs) (at 2016-04-07 09:29:42.802289) ========= 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.bW9twSRqGl/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.RM2HGxHAiA/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.005504 basedir: '/builds/slave/test' ========= master_lag: 10.36 ========= ========= Finished set props: basedir (results: 0, elapsed: 10 secs) (at 2016-04-07 09:29:53.164497) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 30 secs) (at 2016-04-07 09:29:53.164819) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 30 secs) (at 2016-04-07 09:30:23.335981) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 8 secs) (at 2016-04-07 09:30:23.336248) ========= 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.bW9twSRqGl/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.RM2HGxHAiA/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.005467 ========= master_lag: 8.26 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 8 secs) (at 2016-04-07 09:30:31.598782) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 09:30:31.599055) ========= 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:31.599393) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 14 secs) (at 2016-04-07 09:30:31.599666) ========= 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.bW9twSRqGl/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.RM2HGxHAiA/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 154M=0s 2016-04-07 09:30:32 (154 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.515615 ========= master_lag: 14.35 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 14 secs) (at 2016-04-07 09:30:46.468186) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 7 secs) (at 2016-04-07 09:30:46.468465) ========= 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.bW9twSRqGl/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.RM2HGxHAiA/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.020929 ========= master_lag: 7.89 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 7 secs) (at 2016-04-07 09:30:54.382930) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 17 secs) (at 2016-04-07 09:30:54.383238) ========= 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.bW9twSRqGl/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.RM2HGxHAiA/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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,882 truncating revision to first 12 chars 2016-04-07 09:30:56,882 Setting DEBUG logging. 2016-04-07 09:30:56,882 attempt 1/10 2016-04-07 09:30:56,883 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:30:58,536 unpacking tar archive at: fx-team-1725b460c3e0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.904202 ========= master_lag: 15.38 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 17 secs) (at 2016-04-07 09:31:11.662716) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 9 secs) (at 2016-04-07 09:31:11.663031) ========= 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.bW9twSRqGl/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.RM2HGxHAiA/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.005213 script_repo_revision: '1725b460c3e0de97590cb8764df9ace9115b813e' ========= master_lag: 9.81 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 9 secs) (at 2016-04-07 09:31:21.480840) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 11 secs) (at 2016-04-07 09:31:21.481152) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 11 secs) (at 2016-04-07 09:31:32.879933) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-04-07 09:31:32.880223) ========= /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.bW9twSRqGl/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.RM2HGxHAiA/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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:33 INFO - MultiFileLogger online at 20160407 09:31:33 in /builds/slave/test 09:31:33 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:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:31:33 INFO - {'append_to_log': False, 09:31:33 INFO - 'base_work_dir': '/builds/slave/test', 09:31:33 INFO - 'blob_upload_branch': 'Fx-Team', 09:31:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:31:33 INFO - 'branch': 'Fx-Team', 09:31:33 INFO - 'buildbot_json_path': 'buildprops.json', 09:31:33 INFO - 'config_files': ('talos/mac_config.py',), 09:31:33 INFO - 'default_actions': ('clobber', 09:31:33 INFO - 'read-buildbot-config', 09:31:33 INFO - 'download-and-extract', 09:31:33 INFO - 'populate-webroot', 09:31:33 INFO - 'create-virtualenv', 09:31:33 INFO - 'install', 09:31:33 INFO - 'run-tests'), 09:31:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:31:33 INFO - 'download_minidump_stackwalk': True, 09:31:33 INFO - 'download_symbols': 'ondemand', 09:31:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:31:33 INFO - 'tooltool.py': '/tools/tooltool.py', 09:31:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:31:33 INFO - '/tools/misc-python/virtualenv.py')}, 09:31:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:31:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:31:33 INFO - 'installer_path': 'installer.exe', 09:31:33 INFO - 'log_level': 'info', 09:31:33 INFO - 'log_name': 'talos', 09:31:33 INFO - 'log_to_console': True, 09:31:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:31:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:31:33 INFO - 'opt_config_files': (), 09:31:33 INFO - 'pip_index': False, 09:31:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:31:33 INFO - 'cmd': ('bash', 09:31:33 INFO - '-c', 09:31:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:31:33 INFO - 'enabled': True, 09:31:33 INFO - 'halt_on_failure': False, 09:31:33 INFO - 'name': 'check_screen_resolution'},), 09:31:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:31:33 INFO - 'cmd': ('bash', 09:31:33 INFO - '-c', 09:31:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:31:33 INFO - 'enabled': True, 09:31:33 INFO - 'halt_on_failure': False, 09:31:33 INFO - 'name': 'check_screen_resolution'},), 09:31:33 INFO - 'run_cmd_checks_enabled': True, 09:31:33 INFO - 'sps_profile': False, 09:31:33 INFO - 'sps_profile_interval': 0, 09:31:33 INFO - 'suite': 'dromaeojs-e10s', 09:31:33 INFO - 'system_bits': '32', 09:31:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:31:33 INFO - 'title': 't-yosemite-r7-0071', 09:31:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:31:33 INFO - 'use_talos_json': True, 09:31:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:31:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:31:33 INFO - 'work_dir': 'build'} 09:31:33 INFO - ##### 09:31:33 INFO - ##### Running clobber step. 09:31:33 INFO - ##### 09:31:33 INFO - Running pre-action listener: _resource_record_pre_action 09:31:33 INFO - Running main action method: clobber 09:31:33 INFO - rmtree: /builds/slave/test/build 09:31:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:31:35 INFO - Running post-action listener: _resource_record_post_action 09:31:35 INFO - ##### 09:31:35 INFO - ##### Running read-buildbot-config step. 09:31:35 INFO - ##### 09:31:35 INFO - Running pre-action listener: _resource_record_pre_action 09:31:35 INFO - Running main action method: read_buildbot_config 09:31:35 INFO - Using buildbot properties: 09:31:35 INFO - { 09:31:35 INFO - "project": "", 09:31:35 INFO - "product": "firefox", 09:31:35 INFO - "script_repo_revision": "production", 09:31:35 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 09:31:35 INFO - "repository": "", 09:31:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 09:31:35 INFO - "buildid": "20160407091419", 09:31:35 INFO - "stage_platform": "macosx64", 09:31:35 INFO - "basedir": "/builds/slave/test", 09:31:35 INFO - "buildnumber": 663, 09:31:35 INFO - "platform": "yosemite_r7", 09:31:35 INFO - "mozci_request": { 09:31:35 INFO - "priority": -1, 09:31:35 INFO - "type": "trigger_all_talos_jobs", 09:31:35 INFO - "times": 6 09:31:35 INFO - }, 09:31:35 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:31:35 INFO - "slavebuilddir": "test", 09:31:35 INFO - "branch": "fx-team", 09:31:35 INFO - "revision": "1725b460c3e0de97590cb8764df9ace9115b813e", 09:31:35 INFO - "slavename": "t-yosemite-r7-0071", 09:31:35 INFO - "builduid": "11711c41b894477bbe8e36a386a7f8be", 09:31:35 INFO - "repo_path": "integration/fx-team" 09:31:35 INFO - } 09:31:35 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:35 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:35 INFO - Running post-action listener: _resource_record_post_action 09:31:35 INFO - ##### 09:31:35 INFO - ##### Running download-and-extract step. 09:31:35 INFO - ##### 09:31:35 INFO - Running pre-action listener: _resource_record_pre_action 09:31:35 INFO - Running main action method: download_and_extract 09:31:35 INFO - mkdir: /builds/slave/test/build/tests 09:31:35 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:35 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:35 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:35 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:35 INFO - Downloaded 1199 bytes. 09:31:35 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 09:31:35 INFO - Using the following test package requirements: 09:31:35 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:31:35 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:31:35 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 09:31:35 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:31:35 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 09:31:35 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:31:35 INFO - u'jsshell-mac.zip'], 09:31:35 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:31:35 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 09:31:35 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:31:35 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:31:35 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 09:31:35 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:31:35 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 09:31:35 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:31:35 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 09:31:35 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:31:35 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 09:31:35 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:31:35 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:35 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:35 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:35 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:35 INFO - Downloaded 17970713 bytes. 09:31:35 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:35 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:38 INFO - Return code: 0 09:31:38 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:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:38 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:38 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:38 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 - 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.talos.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.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.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.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:31:43 INFO - Downloaded 10847617 bytes. 09:31:43 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:43 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:43 INFO - Return code: 0 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.dmg 09:31:43 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:43 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:44 INFO - Downloaded 108918030 bytes. 09:31:44 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:44 INFO - mkdir: /builds/slave/test/properties 09:31:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:31:44 INFO - Writing to file /builds/slave/test/properties/build_url 09:31:44 INFO - Contents: 09:31:44 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459966130/firefox-48.0a1.en-US.mac.dmg 09:31:44 INFO - Running post-action listener: _resource_record_post_action 09:31:44 INFO - Running post-action listener: set_extra_try_arguments 09:31:44 INFO - ##### 09:31:44 INFO - ##### Running populate-webroot step. 09:31:44 INFO - ##### 09:31:44 INFO - Running pre-action listener: _resource_record_pre_action 09:31:44 INFO - Running main action method: populate_webroot 09:31:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:31:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:31:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:31:44 INFO - '--tppagecycles', 09:31:44 INFO - '7'], 09:31:44 INFO - 'tests': ['tsvgm']}}, 09:31:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:31:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:31:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:31:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:31:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:31:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:31:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:44 INFO - 'talos_options': ['--disable-e10s'], 09:31:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:31:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:31:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:44 INFO - 'talos_options': ['--disable-e10s'], 09:31:44 INFO - 'tests': ['damp', 'tps']}, 09:31:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:44 INFO - 'tests': ['damp', 'tps']}, 09:31:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:31:44 INFO - 'tests': ['dromaeo_dom']}, 09:31:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:31:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:31:44 INFO - 'tests': ['a11yr', 09:31:44 INFO - 'ts_paint', 09:31:44 INFO - 'tpaint', 09:31:44 INFO - 'sessionrestore', 09:31:44 INFO - 'sessionrestore_no_auto_restore', 09:31:44 INFO - 'tabpaint']}, 09:31:44 INFO - 'other-e10s': {'tests': ['a11yr', 09:31:44 INFO - 'ts_paint', 09:31:44 INFO - 'tpaint', 09:31:44 INFO - 'sessionrestore', 09:31:44 INFO - 'sessionrestore_no_auto_restore', 09:31:44 INFO - 'tabpaint']}, 09:31:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:31:44 INFO - 'ts_paint', 09:31:44 INFO - 'tpaint', 09:31:44 INFO - 'sessionrestore', 09:31:44 INFO - 'sessionrestore_no_auto_restore', 09:31:44 INFO - 'tabpaint']}, 09:31:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:31:44 INFO - 'ts_paint', 09:31:44 INFO - 'tpaint', 09:31:44 INFO - 'sessionrestore', 09:31:44 INFO - 'sessionrestore_no_auto_restore', 09:31:44 INFO - 'tabpaint']}, 09:31:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:31:44 INFO - 'tests': ['a11yr', 09:31:44 INFO - 'ts_paint', 09:31:44 INFO - 'tpaint', 09:31:44 INFO - 'sessionrestore', 09:31:44 INFO - 'sessionrestore_no_auto_restore', 09:31:44 INFO - 'tabpaint']}, 09:31:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:31:44 INFO - 'tests': ['a11yr', 09:31:44 INFO - 'ts_paint', 09:31:44 INFO - 'tpaint', 09:31:44 INFO - 'sessionrestore', 09:31:44 INFO - 'sessionrestore_no_auto_restore', 09:31:44 INFO - 'tabpaint']}, 09:31:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:31:44 INFO - 'tests': ['tsvgx', 09:31:44 INFO - 'tsvgr_opacity', 09:31:44 INFO - 'tart', 09:31:44 INFO - 'tscrollx', 09:31:44 INFO - 'cart']}, 09:31:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:31:44 INFO - 'tsvgr_opacity', 09:31:44 INFO - 'tart', 09:31:44 INFO - 'tscrollx', 09:31:44 INFO - 'cart']}, 09:31:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:44 INFO - 'talos_options': ['--disable-e10s'], 09:31:44 INFO - 'tests': ['tp5o']}, 09:31:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:44 INFO - 'tests': ['tp5o']}, 09:31:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:44 INFO - 'talos_options': ['--disable-e10s', 09:31:44 INFO - '--xperf_path', 09:31:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:31:44 INFO - 'tests': ['tp5n']}, 09:31:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:31:44 INFO - 'talos_options': ['--xperf_path', 09:31:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:31:44 INFO - 'tests': ['tp5n']}}, 09:31:44 INFO - 'talos.zip': {'path': '', 09:31:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:31:44 INFO - Running post-action listener: _resource_record_post_action 09:31:44 INFO - ##### 09:31:44 INFO - ##### Running create-virtualenv step. 09:31:44 INFO - ##### 09:31:44 INFO - Running pre-action listener: _resource_record_pre_action 09:31:44 INFO - Running main action method: create_virtualenv 09:31:44 INFO - Creating virtualenv /builds/slave/test/build/venv 09:31:44 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:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:31:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:31:44 INFO - Using real prefix '/tools/python27' 09:31:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:31:45 INFO - Installing distribute.............................................................................................................................................................................................done. 09:31:48 INFO - Installing pip.................done. 09:31:48 INFO - Return code: 0 09:31:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:48 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 0x107945a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107955420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8925914c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077e4e00>, '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 0x10764ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077dfb20>, '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.bW9twSRqGl/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.RM2HGxHAiA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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:48 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:48 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:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bW9twSRqGl/Render', 09:31:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:48 INFO - 'HOME': '/Users/cltbld', 09:31:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:48 INFO - 'LOGNAME': 'cltbld', 09:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:48 INFO - 'MOZ_NO_REMOTE': '1', 09:31:48 INFO - 'NO_EM_RESTART': '1', 09:31:48 INFO - 'PAGER': '/bin/cat', 09:31:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:48 INFO - 'PWD': '/builds/slave/test', 09:31:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:48 INFO - 'SHELL': '/bin/bash', 09:31:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RM2HGxHAiA/Listeners', 09:31:48 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 09:31:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:48 INFO - 'USER': 'cltbld', 09:31:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:48 INFO - 'XPC_FLAGS': '0x0', 09:31:48 INFO - 'XPC_SERVICE_NAME': '0', 09:31:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:48 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:48 INFO - Cleaning up... 09:31:48 INFO - Return code: 0 09:31:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:48 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 0x107945a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107955420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8925914c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077e4e00>, '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 0x10764ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077dfb20>, '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.bW9twSRqGl/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.RM2HGxHAiA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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:48 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:48 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:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bW9twSRqGl/Render', 09:31:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:48 INFO - 'HOME': '/Users/cltbld', 09:31:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:48 INFO - 'LOGNAME': 'cltbld', 09:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:48 INFO - 'MOZ_NO_REMOTE': '1', 09:31:48 INFO - 'NO_EM_RESTART': '1', 09:31:48 INFO - 'PAGER': '/bin/cat', 09:31:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:48 INFO - 'PWD': '/builds/slave/test', 09:31:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:48 INFO - 'SHELL': '/bin/bash', 09:31:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RM2HGxHAiA/Listeners', 09:31:48 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 09:31:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:48 INFO - 'USER': 'cltbld', 09:31:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:48 INFO - 'XPC_FLAGS': '0x0', 09:31:48 INFO - 'XPC_SERVICE_NAME': '0', 09:31:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:49 INFO - Downloading/unpacking psutil>=0.7.1 09:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:31:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:31:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:31:52 INFO - Installing collected packages: psutil 09:31:52 INFO - Running setup.py install for psutil 09:31:53 INFO - building 'psutil._psutil_osx' extension 09:31:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:31:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:31:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:31:53 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:53 INFO - building 'psutil._psutil_posix' extension 09:31:53 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:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:31:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:31:53 INFO - ^ 09:31:53 INFO - 1 warning generated. 09:31:53 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:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:31:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:31:53 INFO - Successfully installed psutil 09:31:53 INFO - Cleaning up... 09:31:53 INFO - Return code: 0 09:31:53 INFO - Installing mozsystemmonitor==0.0.0 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', '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 0x107945a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107955420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8925914c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077e4e00>, '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 0x10764ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077dfb20>, '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.bW9twSRqGl/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.RM2HGxHAiA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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', 'mozsystemmonitor==0.0.0'] 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 mozsystemmonitor==0.0.0 09:31:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bW9twSRqGl/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.RM2HGxHAiA/Listeners', 09:31:53 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:31:54 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:54 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:54 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:54 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:54 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:54 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:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:31:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:31:56 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:31:56 INFO - Installing collected packages: mozsystemmonitor 09:31:56 INFO - Running setup.py install for mozsystemmonitor 09:31:56 INFO - Successfully installed mozsystemmonitor 09:31:56 INFO - Cleaning up... 09:31:56 INFO - Return code: 0 09:31:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:31:56 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:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:56 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:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:56 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 0x107945a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107955420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8925914c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077e4e00>, '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 0x10764ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077dfb20>, '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.bW9twSRqGl/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.RM2HGxHAiA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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:56 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:31:56 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:31:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bW9twSRqGl/Render', 09:31:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:56 INFO - 'HOME': '/Users/cltbld', 09:31:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:56 INFO - 'LOGNAME': 'cltbld', 09:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:56 INFO - 'MOZ_NO_REMOTE': '1', 09:31:56 INFO - 'NO_EM_RESTART': '1', 09:31:56 INFO - 'PAGER': '/bin/cat', 09:31:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:56 INFO - 'PWD': '/builds/slave/test', 09:31:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:56 INFO - 'SHELL': '/bin/bash', 09:31:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RM2HGxHAiA/Listeners', 09:31:56 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 09:31:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:56 INFO - 'USER': 'cltbld', 09:31:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:56 INFO - 'XPC_FLAGS': '0x0', 09:31:56 INFO - 'XPC_SERVICE_NAME': '0', 09:31:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:57 INFO - Downloading/unpacking blobuploader==1.2.4 09:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:59 INFO - Downloading blobuploader-1.2.4.tar.gz 09:31:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:31:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:32:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:00 INFO - Downloading docopt-0.6.1.tar.gz 09:32:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:32:00 INFO - Installing collected packages: blobuploader, requests, docopt 09:32:00 INFO - Running setup.py install for blobuploader 09:32:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:32:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:32:00 INFO - Running setup.py install for requests 09:32:01 INFO - Running setup.py install for docopt 09:32:01 INFO - Successfully installed blobuploader requests docopt 09:32:01 INFO - Cleaning up... 09:32:01 INFO - Return code: 0 09:32:01 INFO - Installing None 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', '--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 0x107945a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107955420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8925914c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077e4e00>, '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 0x10764ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077dfb20>, '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.bW9twSRqGl/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.RM2HGxHAiA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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', '--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:01 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:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bW9twSRqGl/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.RM2HGxHAiA/Listeners', 09:32:01 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:32:01 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-R1kuFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:32:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:32:01 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-kRSAcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:32:02 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-9jYYS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:32:02 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-v0YIf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:32:02 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-L7JSRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:32:02 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-NZvSvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:32:02 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-Gk69YM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:32:02 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-SC77Ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:32:02 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-I8uSz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:32:02 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-5ciFqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:32:02 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-Fl_Ciw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:32:03 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-zulfpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:32:03 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-MRMD4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:32:03 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-WnqI4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:03 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-iJKtxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:32:03 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-oGeFIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:32:03 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-nrNu2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:32:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:32:03 INFO - Running setup.py install for manifestparser 09:32:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:32:03 INFO - Running setup.py install for mozcrash 09:32:03 INFO - Running setup.py install for mozdebug 09:32:04 INFO - Running setup.py install for mozdevice 09:32:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:32:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:32:04 INFO - Running setup.py install for mozfile 09:32:04 INFO - Running setup.py install for mozhttpd 09:32:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:32:04 INFO - Running setup.py install for mozinfo 09:32:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:32:04 INFO - Running setup.py install for mozInstall 09:32:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:32:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:32:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:32:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:32:04 INFO - Running setup.py install for mozleak 09:32:05 INFO - Running setup.py install for mozlog 09:32:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:32:05 INFO - Running setup.py install for moznetwork 09:32:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:32:05 INFO - Running setup.py install for mozprocess 09:32:05 INFO - Running setup.py install for mozprofile 09:32:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:32:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:32:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:32:05 INFO - Running setup.py install for mozrunner 09:32:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:32:05 INFO - Running setup.py install for mozscreenshot 09:32:05 INFO - Running setup.py install for moztest 09:32:06 INFO - Running setup.py install for mozversion 09:32:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:32:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:32:06 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', '--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 0x107945a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107955420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8925914c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077e4e00>, '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 0x10764ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077dfb20>, '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.bW9twSRqGl/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.RM2HGxHAiA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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', '--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 --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.bW9twSRqGl/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.RM2HGxHAiA/Listeners', 09:32:06 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-OX1P_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:32:06 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:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:32:06 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-lAwivh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:32:06 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:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:32:06 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-H5E6SK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:32:06 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:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:32:06 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-dgHOVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:32:06 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:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:32:06 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-S8mUWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:32:07 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:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:32:07 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-B_pT05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:32:07 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:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:32:07 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-D_vtWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:32:07 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:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:32:07 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-6MtUJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:32:07 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:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:32:07 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-4BrW12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:32:07 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:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:32:07 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-DfVHja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:32:07 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:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:32:07 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-xB_Efu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:32:07 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:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:32:07 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-CcQSVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:32:07 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:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:32:07 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-BL7ZJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:32:07 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:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:32:07 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-0X_54w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:32:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:08 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-06v1WK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:32:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:32:08 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-jDe9cN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:32:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:32:08 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-qUKt2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:32:08 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:08 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:08 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:08 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:08 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:08 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:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:10 INFO - Downloading blessings-1.6.tar.gz 09:32:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:32:10 INFO - Installing collected packages: blessings 09:32:10 INFO - Running setup.py install for blessings 09:32:11 INFO - Successfully installed blessings 09:32:11 INFO - Cleaning up... 09:32:11 INFO - Return code: 0 09:32:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:32:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:32:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:32:11 INFO - Reading from file tmpfile_stdout 09:32:11 INFO - Current package versions: 09:32:11 INFO - blessings == 1.6 09:32:11 INFO - blobuploader == 1.2.4 09:32:11 INFO - docopt == 0.6.1 09:32:11 INFO - manifestparser == 1.1 09:32:11 INFO - mozInstall == 1.12 09:32:11 INFO - mozcrash == 0.17 09:32:11 INFO - mozdebug == 0.1 09:32:11 INFO - mozdevice == 0.48 09:32:11 INFO - mozfile == 1.2 09:32:11 INFO - mozhttpd == 0.7 09:32:11 INFO - mozinfo == 0.9 09:32:11 INFO - mozleak == 0.1 09:32:11 INFO - mozlog == 3.1 09:32:11 INFO - moznetwork == 0.27 09:32:11 INFO - mozprocess == 0.22 09:32:11 INFO - mozprofile == 0.28 09:32:11 INFO - mozrunner == 6.11 09:32:11 INFO - mozscreenshot == 0.1 09:32:11 INFO - mozsystemmonitor == 0.0 09:32:11 INFO - moztest == 0.7 09:32:11 INFO - mozversion == 1.4 09:32:11 INFO - psutil == 3.1.1 09:32:11 INFO - requests == 1.2.3 09:32:11 INFO - wsgiref == 0.1.2 09:32:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:11 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 0x107945a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107955420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8925914c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077e4e00>, '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 0x10764ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077dfb20>, '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.bW9twSRqGl/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.RM2HGxHAiA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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:11 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:11 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:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bW9twSRqGl/Render', 09:32:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:11 INFO - 'HOME': '/Users/cltbld', 09:32:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:11 INFO - 'LOGNAME': 'cltbld', 09:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:11 INFO - 'MOZ_NO_REMOTE': '1', 09:32:11 INFO - 'NO_EM_RESTART': '1', 09:32:11 INFO - 'PAGER': '/bin/cat', 09:32:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:11 INFO - 'PWD': '/builds/slave/test', 09:32:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:11 INFO - 'SHELL': '/bin/bash', 09:32:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RM2HGxHAiA/Listeners', 09:32:11 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 09:32:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:11 INFO - 'USER': 'cltbld', 09:32:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:11 INFO - 'XPC_FLAGS': '0x0', 09:32:11 INFO - 'XPC_SERVICE_NAME': '0', 09:32:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:11 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:11 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:11 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:11 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:11 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:11 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:11 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:11 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:11 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:11 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:11 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:11 INFO - Cleaning up... 09:32:11 INFO - Return code: 0 09:32:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:11 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 0x107945a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107955420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8925914c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077e4e00>, '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 0x10764ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077dfb20>, '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.bW9twSRqGl/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.RM2HGxHAiA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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:11 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:11 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:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bW9twSRqGl/Render', 09:32:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:11 INFO - 'HOME': '/Users/cltbld', 09:32:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:11 INFO - 'LOGNAME': 'cltbld', 09:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:11 INFO - 'MOZ_NO_REMOTE': '1', 09:32:11 INFO - 'NO_EM_RESTART': '1', 09:32:11 INFO - 'PAGER': '/bin/cat', 09:32:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:11 INFO - 'PWD': '/builds/slave/test', 09:32:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:11 INFO - 'SHELL': '/bin/bash', 09:32:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RM2HGxHAiA/Listeners', 09:32:11 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 09:32:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:11 INFO - 'USER': 'cltbld', 09:32:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:11 INFO - 'XPC_FLAGS': '0x0', 09:32:11 INFO - 'XPC_SERVICE_NAME': '0', 09:32:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:11 INFO - Downloading/unpacking jsonschema 09:32:11 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:11 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:11 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:11 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:11 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:11 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:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:32:14 INFO - Downloading/unpacking functools32 (from jsonschema) 09:32:14 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:14 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:14 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:14 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:14 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:14 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:14 INFO - Downloading functools32-3.2.3-2.tar.gz 09:32:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:32:14 INFO - warning: no files found matching '*.txt' 09:32:14 INFO - no previously-included directories found matching 'build' 09:32:14 INFO - no previously-included directories found matching 'dist' 09:32:14 INFO - no previously-included directories found matching '.git*' 09:32:14 INFO - Installing collected packages: jsonschema, functools32 09:32:14 INFO - Running setup.py install for functools32 09:32:14 INFO - warning: no files found matching '*.txt' 09:32:14 INFO - no previously-included directories found matching 'build' 09:32:14 INFO - no previously-included directories found matching 'dist' 09:32:14 INFO - no previously-included directories found matching '.git*' 09:32:14 INFO - Successfully installed jsonschema functools32 09:32:14 INFO - Cleaning up... 09:32:15 INFO - Return code: 0 09:32:15 INFO - Installing flake8 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', '--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 0x107945a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107955420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8925914c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077e4e00>, '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 0x10764ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077dfb20>, '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.bW9twSRqGl/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.RM2HGxHAiA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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', '--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:15 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:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bW9twSRqGl/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.RM2HGxHAiA/Listeners', 09:32:15 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:15 INFO - Downloading/unpacking flake8 09:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:32:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:32:17 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:17 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:17 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:17 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:17 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:17 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 mccabe-0.3.1-py2.py3-none-any.whl 09:32:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 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:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 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 - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:32:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:32:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:32:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:32:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:32:19 INFO - no previously-included directories found matching 'docs/_build' 09:32:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:32:19 INFO - Running setup.py install for pep8 09:32:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:32:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:32:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:32:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:32:19 INFO - no previously-included directories found matching 'docs/_build' 09:32:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:32:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:32:19 INFO - Cleaning up... 09:32:19 INFO - Return code: 0 09:32:19 INFO - Running post-action listener: _resource_record_post_action 09:32:19 INFO - Running post-action listener: _start_resource_monitoring 09:32:19 INFO - Starting resource monitoring. 09:32:19 INFO - ##### 09:32:19 INFO - ##### Running install step. 09:32:19 INFO - ##### 09:32:19 INFO - Running pre-action listener: _resource_record_pre_action 09:32:19 INFO - Running main action method: install 09:32:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:32:19 INFO - Reading from file tmpfile_stdout 09:32:19 INFO - Detecting whether we're running mozinstall >=1.0... 09:32:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:32:19 INFO - Reading from file tmpfile_stdout 09:32:19 INFO - Output received: 09:32:19 INFO - Usage: mozinstall [options] installer 09:32:19 INFO - Options: 09:32:19 INFO - -h, --help show this help message and exit 09:32:19 INFO - -d DEST, --destination=DEST 09:32:19 INFO - Directory to install application into. [default: 09:32:19 INFO - "/builds/slave/test"] 09:32:19 INFO - --app=APP Application being installed. [default: firefox] 09:32:19 INFO - mkdir: /builds/slave/test/build/application 09:32:19 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:19 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:52 INFO - Reading from file tmpfile_stdout 09:32:52 INFO - Output received: 09:32:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:32:52 INFO - Running post-action listener: _resource_record_post_action 09:32:52 INFO - ##### 09:32:52 INFO - ##### Running run-tests step. 09:32:52 INFO - ##### 09:32:52 INFO - Running pre-action listener: _resource_record_pre_action 09:32:52 INFO - Running main action method: run_tests 09:32:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:32:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:32:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:32:52 INFO - 2016-04-07 09:32:52.971 screenresolution[2316:26486] starting screenresolution argv=screenresolution get 09:32:52 INFO - 2016-04-07 09:32:52.974 screenresolution[2316:26486] Display 0: 1600x1200x32@60 09:32:52 INFO - 2016-04-07 09:32:52.980 screenresolution[2317:26489] starting screenresolution argv=screenresolution list 09:32:52 INFO - Available Modes on Display 0 09:32:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:32:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:32:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:32:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:32:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:32:53 INFO - Intel Iris: 09:32:53 INFO - Chipset Model: Intel Iris 09:32:53 INFO - Type: GPU 09:32:53 INFO - Bus: Built-In 09:32:53 INFO - VRAM (Dynamic, Max): 1536 MB 09:32:53 INFO - Vendor: Intel (0x8086) 09:32:53 INFO - Device ID: 0x0a2e 09:32:53 INFO - Revision ID: 0x0009 09:32:53 INFO - Displays: 09:32:53 INFO - Display: 09:32:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:32:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:32:53 INFO - Display Serial Number: 1600x1200 60 09:32:53 INFO - Main Display: Yes 09:32:53 INFO - Mirror: Off 09:32:53 INFO - Online: Yes 09:32:53 INFO - Rotation: Supported 09:32:53 INFO - Return code: 0 09:32:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:32:53 INFO - Python 2.7.3 09:32:53 INFO - Return code: 0 09:32:53 INFO - grabbing minidump binary from tooltool 09:32: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:32:53 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 0x1077e4e00>, '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 0x10764ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077dfb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:32:53 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:53 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:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:32:53 INFO - Return code: 0 09:32:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:32:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:32:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:32:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:32:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:32:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:32:54 INFO - Return code: 0 09:32:54 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-0071', '--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:32:54 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-0071 --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:32:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bW9twSRqGl/Render', 09:32:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:54 INFO - 'HOME': '/Users/cltbld', 09:32:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:54 INFO - 'LOGNAME': 'cltbld', 09:32:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:32:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:54 INFO - 'MOZ_NO_REMOTE': '1', 09:32:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:32:54 INFO - 'NO_EM_RESTART': '1', 09:32:54 INFO - 'PAGER': '/bin/cat', 09:32:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:54 INFO - 'PWD': '/builds/slave/test', 09:32:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:32:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:54 INFO - 'SHELL': '/bin/bash', 09:32:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RM2HGxHAiA/Listeners', 09:32:54 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 09:32:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:54 INFO - 'USER': 'cltbld', 09:32:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:54 INFO - 'XPC_FLAGS': '0x0', 09:32:54 INFO - 'XPC_SERVICE_NAME': '0', 09:32:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:54 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-0071', '--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:32:54 INFO - mozversion application_buildid: 20160406110850 09:32:54 INFO - mozversion application_changeset: 1725b460c3e0de97590cb8764df9ace9115b813e 09:32:54 INFO - mozversion application_display_name: Nightly 09:32:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:32:54 INFO - mozversion application_name: Firefox 09:32:54 INFO - mozversion application_remotingname: firefox 09:32:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:32:54 INFO - mozversion application_vendor: Mozilla 09:32:54 INFO - mozversion application_version: 48.0a1 09:32:54 INFO - mozversion platform_buildid: 20160406110850 09:32:54 INFO - mozversion platform_changeset: 1725b460c3e0de97590cb8764df9ace9115b813e 09:32:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:32:54 INFO - mozversion platform_version: 48.0a1 09:32:54 INFO - using testdate: 1460046774 09:32:54 INFO - actual date: 1460046774 09:32:54 INFO - starting webserver on 'localhost:59154' 09:32:54 INFO - SUITE-START | Running 2 tests 09:32:54 INFO - TEST-START | dromaeo_css 09:32:54 INFO - operating with platform_type : mac_ 09:32:54 INFO - Initialising browser for dromaeo_css test... 09:32:54 INFO - TEST-INFO | started process 2335 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpUJFQ_b/profile http://localhost:59154/getInfo.html) 09:32:57 INFO - PROCESS | 2335 | 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:32:57 INFO - PROCESS | 2335 | __metrics Screen width/height:1600/1200 09:32:57 INFO - PROCESS | 2335 | colorDepth:24 09:32:57 INFO - PROCESS | 2335 | Browser inner width/height: 1024/689 09:32:57 INFO - PROCESS | 2335 | __metrics 09:32:57 ERROR - PROCESS | 2335 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 09:32:58 INFO - TEST-INFO | 2335: exit 0 09:32:58 INFO - Browser initialized. 09:32:58 INFO - Running cycle 1/1 for dromaeo_css test... 09:32:58 INFO - TEST-INFO | started process 2338 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpUJFQ_b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:33:10 INFO - PROCESS | 2338 | RSS: Main: 247341056 09:33:10 INFO - PROCESS | 2338 | 09:33:59 INFO - PROCESS | 2338 | 1460046839740 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:10 INFO - PROCESS | 2338 | Cycle 1(1): loaded http://localhost:59154/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59154/tests/dromaeo/cssquery-ext.html) 09:36:11 INFO - PROCESS | 2338 | RSS: Main: 260001792 09:36:11 INFO - PROCESS | 2338 | 09:39:13 INFO - PROCESS | 2338 | Cycle 1(1): loaded http://localhost:59154/tests/dromaeo/cssquery-ext.html (next: http://localhost:59154/tests/dromaeo/cssquery-jquery.html) 09:39:14 INFO - PROCESS | 2338 | RSS: Main: 271679488 09:39:14 INFO - PROCESS | 2338 | 09:42:16 INFO - PROCESS | 2338 | Cycle 1(1): loaded http://localhost:59154/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59154/tests/dromaeo/cssquery-mootools.html) 09:42:16 INFO - PROCESS | 2338 | RSS: Main: 272838656 09:42:16 INFO - PROCESS | 2338 | 09:45:18 INFO - PROCESS | 2338 | Cycle 1(1): loaded http://localhost:59154/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59154/tests/dromaeo/cssquery-prototype.html) 09:45:19 INFO - PROCESS | 2338 | RSS: Main: 276365312 09:45:19 INFO - PROCESS | 2338 | 09:48:21 INFO - PROCESS | 2338 | Cycle 1(1): loaded http://localhost:59154/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59154/tests/dromaeo/cssquery-yui.html) 09:48:22 INFO - PROCESS | 2338 | RSS: Main: 276008960 09:48:22 INFO - PROCESS | 2338 | 09:51:24 INFO - PROCESS | 2338 | Cycle 1(1): loaded http://localhost:59154/tests/dromaeo/cssquery-yui.html (next: http://localhost:59154/tests/dromaeo/cssquery-dojo.html) 09:51:25 INFO - PROCESS | 2338 | RSS: Main: 279834624 09:51:25 INFO - PROCESS | 2338 | 09:51:25 INFO - PROCESS | 2338 | __start_tp_report 09:51:25 INFO - PROCESS | 2338 | _x_x_mozilla_page_load 09:51:25 INFO - PROCESS | 2338 | _x_x_mozilla_page_load_details 09:51:25 INFO - PROCESS | 2338 | |i|pagename|runs| 09:51:25 INFO - PROCESS | 2338 | |0;dojo.html;3330.4837750148727;3398.796072235666;3479.5476588043553;3497.4404095344735;3518.208403109299;5709.029464990951;5745.052066409037;5747.655140691561;5772.365039845619;5775.855603609906;5623.606347555673;5629.845881594274;5638.323401191852;5731.254936858202;5859.7070146492715;5096.362954630662;5162.793488260484;5192.506711862386;5212.556932660709;5244.973775131138;441.9089055543568;5092.134337162673;5186.429492755794;5209.32278803755;5219.825539253676;5179.948200517984;5182.792688292464;5202.4277329493725;5215.348081489814;5216.739163041871;5203.635745497817;5221.39953905302;5222.112240919015;5240.685558866442;5265.631405801595;5111.437741848394;5113.718745468997;5189.2475591039465;5200.115980283361;5205;5604.775808967636;5632.549396048306;5676.262085928803;5681.886362272731;5728.0238317780295;6126.969365153191;6188.535859810532;6277.968610156966;6287.622742635456;6295.685215739195;6171.413715697002;6232.376762323776;6278.089676996809;6284.151639528651;6287.6856157192415;5808.564357673149;5846.181534585162;5852.122181672783;5857.912131318076;5880.382559831241;6182.474489668339;6211.9068213976825;6262.436380725757;6267.6866156691985;6276.686165691788;5020.748962551857;5045.495450454925;5101.795928162906;5200.6619569727845;6220;6209;6237.4698150657705;6260.968695156586;6274.780382686584;6288.182536270256;4971;6130.111133885562;6135.232666670055;6188.164597779332;6199.3490683478485;4869.9026019480125;6248.812535623939;6249.75000999964;6250.9062364064575;6293;4929.679570827885;4935.654504184673;4938;4941.925871111936;4983.8504844854715;4336.739795612273;4362.498312694081;4380.67144964129;4452.2431186697695;4512.638988880882;5617.8033768817895;5694.003549378842;5704.22992895962;5726.284214473191;5756.02147634903;6218.9378106219265;6267.059941008794;6278.340774218733;6282.717277722422;6291.213598300213;5163.586913046947;5619.466150715675;5633.126865335879;5730.1404789281105;5741.397153298927;5316.787328506816;5385.165299378603;5398.973005135028;5412.648177868505;5414.593905457028;6286.339934306923;6314.494840412756;6316.399942005502;6320.431161195606;6451.677416129175;6142.959235178615;6171.938280617136;6220.657863817352;6260.092286618324;6280.591761535486;6255.061740738925;6256.786237261826;6288.779892703734;6310.7475700971445;6444.8388790280615;6218.875622487615;6265.4361107500545;6268.498520118288;6269.49844012487;6291.087792270187;6158.3225845157895;6196.752129914933;6239.594426362272;6247.0629405589525;6247.468965137832;5990.64056156632;6010.678567159393;6151.3541078186145;6151.384861513813;6189.0097584386285;5314.707691077027;6182.196314479269;6192.845178870384;6194.5973511721595;6207.193064901534;5134.9486505135965;5998.430149135826;6050.273967123973;6054.3340232575265;6106.236720409949;6132.264128304632;6147.877042459037;6192.442680158807;6197.349278325711;6243.157173781481;5892.116182572477;5983.132445795248;6054.455099040932;6096.878062438637;6097.146399504161 09:51:25 INFO - PROCESS | 2338 | |1;ext.html;450.3919708393669;500.7095884387057;583.5944018906862;589.7320760365211;632.6710110742413;33428.4985725214;38190.23619527608;38269.42595861064;38338.424923626095;38450.84647460577;39223.803880980624;39275.41086883699;39641.801790991005;39729.205415891665;39822.80088599553;9301.348905576613;9461.574229159703;9562.952185239099;9577.329586928918;9591.760205994837;9504.334696571243;9511.714648560554;9604.471754053524;9606.855897161548;9641.13229809317;9590.80818383632;9641.951790241039;9663.4201947883;9669.323147379686;9710.271729620272;9565.234781217521;9592.904070959341;9605.279604029725;9662.227021838236;9677.516124193797;9503.192228660571;9664.565094570762;9675.516224188832;9681.467519286436;9686;37748.62251377478;37998.81000595007;38148.80925595354;38346.616533834866;38453;2757.9724202758116;3038.453078445879;3066.509358502629;3303.9834800825843;3359.5296658467832;26404.20787376382;27385.589216161774;27762.167134985983;27768.02811901594;28091.157265282076;2713.9592906106423;2749.2164733050986;2806.494830930432;2857.171420288114;2866.383727498577;422691;424564;425087;425753;425766;45095.54904450979;45523;59358.703206484555;61001.69499152476;61281.08078378828;45192.548074519495;46408.303875441896;46489.07021859611;46549.30176047362;46671.06657866824;13693.520726774515;15853.128077955593;16048.919755401148;16161.838381616033;16175.94856334358;12475.376231188404;12715.618531444072;12923.353832308347;12974.416151273215;12987.350632468339;14323.856761432253;14345.713085738436;14584.343704533321;14591;14663.853361466463;6188.504919606511;6267.874642507124;6280.7487700491465;6322.9051564226575;6352.460040896483;930.7254359963827;955.8518429643277;1069.3102948598112;1096.4846522134585;1146.9541218351173;24412.023519059392;25055.749442505705;29032.419351613273;29319.413611727647;29619;991.5141580625442;1048.6681913969217;1094.4035500652165;1104.2932523185168;1121.7812526557243;14252.857471425154;14253.216073115871;14531.273436328142;14550.4907328243;14574.708505829823;528239;530096;534777;536461;536950;56955;57065;57784.71107644435;58046.4195358041;58096;1381.530279704905;1420.3040510150158;1458.4530800949644;1461.3423959218394;1464.9047811892192;24671.136510222055;28501.572476412457;28550.143495695163;28983.7101628981;29151.562726559543;37470.06324841901;45426;49214.26178607252;49795.25307120324;49921;497809;499632;501066;501242.97514050244;501841;33026.504602431465;33285.833570831994;33458.33083338368;33770.324593508485;34005.319893602486;44579.55420445884;45669.85825354393;45688.54311456976;45848;46102;36396.818015909754;36754;37005.44491832571;37310.813445932596;37617.24765504729;30383;34670.47994280138;36681.266374672894;36814.8159259202;37129.62870371262;31332.90334838361;36127.638723613476;36642.633573664985;36972.26055478929;37221;30270.54594181045;31623;32524.674753252166;32940.835295823366;32948;19487.92670695247;23543.41141471477;23825.404364890324;23953.64069538993;24230.51538969246 09:51:25 INFO - PROCESS | 2338 | |2;jquery.html;358.31204088150747;362.16701586351394;364.9470826730124;370.189285464832;374.34115955917576;18701.71947420788;19169;20495.897520512415;20506;20574.074166662518;19660.508487287825;19690.11394487248;19817.702734458995;20003.699944500808;20294.188232470682;5664.20701101846;5978.701064946736;5981.850453738648;5985.970070149643;6017.789377371793;3647.598764135943;5832.358440571534;6200.945839207346;6642.900356494656;6667.066610674509;6482.481401487869;6576.112224849632;6596.43930265928;6602.009698545208;6617.834554136137;7023.403010744068;7370.373518250955;7387.963060184691;7399.519031263005;7411.48119631626;6871.484638652071;6958.617276049815;6999.545029573062;7017.57894526325;7062.54093483927;25464;26422.867885660642;26832;27029.864850675818;27637;2204.889755512218;2292.3008482412856;2355.7644235576304;2374.662293513053;2523.8107141964424;14200.360983755756;15016.699666006618;15079.944403891732;15428.460003899809;15781.60545986348;1797.6494583556212;1818.6635472437642;1858.7304840798145;1871.3543827379533;1903.5146037760421;111888.4405577967;111978.44010779895;114682;116516.41741791237;119893.40053299765;18684.719729204073;18696.626067478574;18921.905390473235;18934.337298194496;19275.132619032178;22834;28631.427371452453;28662.28344291368;28713.133646312923;28728.712712872602;10512.737181570523;10542.420166890895;10896.18278629106;10923;11001.394923279297;7403.8149046274275;8396.118407567117;8477.237048665527;9371.48456834867;9375.859362109573;7715.498492597963;7940.523568585903;8460.407771455939;8545.359098067669;8624.78438039054;2843.317603775079;3297.554830097954;3319.5850518685165;3326.101952472867;3517.8944631661093;882.3955590420583;892.2906289499863;942.2791564453199;962.9711108666751;986.5511192407438;16611.754118441164;18348;18853.82680381543;20096.196152154043;20659.967001649857;938.7934654376027;954.4178051388648;990.2919412620012;994.3735446668552;1036.5542816588938;8759.824803503894;9106.86339704905;9970.750731231778;10682.946585267024;10743.194260430499;510990;521250;549827;592238;610774;118791.40604296923;119885.40057299657;120338.19492707617;121576;122395;1009.9697009089739;1038.0999505195448;1041.0526420957044;1047.0733849716405;1048.308116643012;17386.13069346553;17688.55778605545;17925.641487170444;18006.459806205836;18398.540036499195;37588.248235034596;44597.33104003378;45917.622471325914;45925;46533;65290;65522.672386637765;69320;69437.30562694308;70261;7506.962465187639;7542.6605802740105;7574.772756817304;7671.38628909697;7860.449768516378;10854.945725271324;11878.346690932081;12050.156489045683;12097.347552638565;12211.511539538318;10524.631637892637;10617.203709721647;10892.945535272273;10900;10948.397838118979;10268.794624107626;10455.529501172314;10555.63055293061;10777.568897244022;10917.727056823644;10680.305780124267;10723.463826808473;10846.67459976202;10938.179636527133;11101.000909918146;7513.4740568159705;7549.547027178167;7612.619369031416;7623.656935437808;7836;9126.361154719107;10626.468676566295;10630.8405373921;10853.34879907208;10885.074768644754 09:51:25 INFO - PROCESS | 2338 | |3;mootools.html;1632.5428879913625;1635.8773092018098;1920.5006698258449;1994.6409646263685;2013.7885522020179;7941.28528432441;8672.8699069514;8679.349048821348;8880.689175878846;8880.911190888097;7961.60191990401;8671.566421678923;8686.782830429242;8789.516576588285;8809.38334316598;2069.203356707671;2281.6007198740194;2458.4591389894194;2478.3432390416556;2488.091846476032;1972.8557436686688;2252.245497758253;2499.4126380300613;2516.6854143232094;2517.6349429332736;2060.1965233558926;2183.6942828004094;2301.5166814968793;2492.3519884829893;2505.260948020329;2469.987650061756;2473.6042233242683;2485.391079185593;2487.345914966545;2490.1906880263987;2465.778079972793;2490.651308816767;2494.2641920633455;2494.750524947509;2503.4242124311327;8899.955500222522;8902.910970890272;8984.28125749945;9004.684836030772;9005.729828105103;4976.402831660188;5227.294315267428;5373.35519737634;5484.533814625762;5560.443955604448;3555.1289933966345;3634.963650363489;3671.1372827385544;3684.207895302496;3720.665140137374;1015.441507171053;1032.7521394865178;1034.1468288661883;1034.6378767431413;1034.7154532503546;11809.881901180965;11907;12010.879891201064;12020.91811736939;12021.639350819489;4781.545753153445;4876.122297986326;4909.5090490950615;4943.703377797344;4959.181735013754;10085.697429076992;10140.594376224868;10152.796944061078;10164.593416263415;10188.235882308709;5429.809956651498;5521.171824226398;5538.418466061086;5538.778448862081;5546.112621980464;4491.955080449219;4874.488178741252;4917.164082106051;4963.925541116886;4993.875153121201;3861.1698484825897;3882.2623701496627;3956.287868183697;3958.802059896994;4035.8183881725395;1314.3428285857071;1316.8683131686755;1318.641798947086;1327.502186679995;1333.6532501549473;1079.3200283821143;1079.8056349857102;1289.4133169407896;1359.9800149887585;1385.7990591364196;7011.649417529103;8301.709440169565;8303.04514980785;8315.916840831514;8329.458585191944;493.2428721911848;499.4381321013859;499.95750361219706;500.4220125754759;520.3079903728033;6189.721462534197;6201.720922558496;6253.437190652772;6253.6873156342;6261.154744109578;10494.580216791395;10855.728606784893;10885.564577416973;10892.509837057192;11057.557697692164;10481.056704896444;10797.676069717922;10826.62106826273;10833.78332433347;10868.565257389615;7583.7724868254045;7912.6152923238205;8415.45299555527;8484.43038037965;8527.062023177445;7676.923230767844;7700.653470593725;7852.568108753845;7983.720569780262;7998.600069996593;8024.598770061357;9519.190868775955;9563.234941204826;9648.71053868385;9731.416115032838;9835.213182945205;9956.751081223027;10012.44931528773;10056.29605927578;10086;6782.93217067823;7268.0914885639295;7538.660760265691;7577.469577129548;7659.731909383145;8329.083800781787;8349.916500834914;8368.163183681583;8388.58057097155;8394.916050839658;7362;7552.66013029426;7577.760768213755;7587.089549254125;7659.042619672541;7392.778216653509;7415.740449084256;7487.775366739006;7511.549307041595;7594.202608726005;7685.577293248925;7800.92199078002;7871.370290376871;7876.606169691607;7877.606119694107;6685.097511836035;6766.4248538874745;6774.288699686659;6811.4550835934;6825.35159159879;7204.9639751800905;7249.42004639617;7250;7270.527415717961;7274.709011639475 09:51:25 INFO - PROCESS | 2338 | |4;prototype.html;319.9456092464281;329.2378144595262;331.3207923756299;333.21195372943;336.61457631012485;6820.352066553675;6862.382385585296;6875.243723190445;6877.552959057658;6911.516193866431;5632.746526406311;6656.234533028691;6670.332966703328;6788.660566971644;6856.965715171417;4825.372701548794;4877.292792545079;4960.479149689285;4979.7261150636705;5062.797488100481;4987.17711577591;4999.825041115335;5021.899562008758;5022.924656130161;5031.396232452111;4968.056069346812;4971.776270067856;4985.800567977277;5013.373328333958;5038.571721403685;4269.146170765844;4770.833020844271;4973.825916092956;4999.925001124986;5008.424031236418;3520.5775306963073;4296.914061718748;4305.655547556188;4308.46144231971;4310.849120280806;6293.37066293367;6588.374104460068;6588.538802283842;6612.702428390734;6687.097241872334;5856.882862342772;5902;5907.852303692399;5912.852178695524;5916.911246331309;7369.557826530426;7374.483786134972;7389.371903388218;7397.926020739777;7414;3466.30673865228;4173.499180098377;4227.4292970448905;4338.978305108454;4704.764761761932;7278.563286202845;7425.925740742631;7708.653110610036;7834.0990786059765;7859.292663660241;3974.3839704845795;4648.628109751212;4731.810727570859;4755.2153894607;4762.404699412574;4861.246506791453;4862.367892173995;4864.318995340655;4865.537773911544;4882.658213924991;5409.891802163935;5732.054211055212;5895;5901.734421951022;5916.674582897982;7420.814479638052;7422.294881986203;7428.922806193072;7433.070866141732;7462.776116716507;1590.7295759720876;1636.885418020727;1649.2578339747163;1667.132811251406;1676.1535424610738;1047.1936608811325;1049.21833234241;1067.4876059491332;1068.834330678746;1069.8769641491172;5836.445537673914;6676.899846502306;6680.732770689216;6711.362420570038;6711.395974362331;6149.41580549847;7632.80917977055;7638.847223055508;7648.464607477535;7668.38652907766;6704.564203326768;6735.797926062226;6744;6765.830854228684;6778.423833974069;3309.7352211822995;3952.1700442906736;4053.959460405358;4087.9795601021806;4096.897577560585;6896.310368963063;7638.847223055508;7830.177831327743;8074.677012919535;8156.184381561915;6940.930590694129;7952.483088599222;8038.758837234892;8039.437239393186;8087.47431416956;8043.517388956681;8073.5963201838495;8078.596070196467;8081.959590202011;8103.068147162916;7484.663190156565;7723.691052357843;7770.844583108194;7843.764687059397;7856.057273127261;7546.660535234095;7615.276548727862;7649.6557654904545;7658.6170691464085;7686.500377475446;8045.637946292314;8049.154838741848;8067.515949043076;8067.83864322722;8073.35413166957;4726.338312636302;4777.928331074967;4782.139214941344;4791.856244312677;4807.591354734886;7494.17564067963;7650.8087297818;7755.495892766952;7761.223877612194;7775.844483110419;7452.739154129579;7454.6645400956;7487.176410594721;7498.775036748906;7514.323710866049;7464;7466.514676546007;7476.626168691435;7479.252074792477;7557.395408367427;6980.965095174492;7261.564306141649;7262.745803896838;7282.235365286569;7327.4504412168235;6040.939590604038;7413.1104267488245;7454.366378857858;7464.776056718307;7465.776026719207;7212.89180662301;7267.781966540801;7283.380912622486;7292.34368906801;7324.4140468763435 09:51:25 INFO - PROCESS | 2338 | |5;yui.html;634.4068296143107;637.6333608175299;656.8865772515585;687.2920593398611;733.1605311917857;14410.711785764292;14670.926645366784;14672.413103475861;14753.704925901475;14790.926045369784;13494.46022159115;13561;13633.182009079437;13661.112027718216;13685.178889266626;728.9234630363815;876.6274333408276;878.1876763993329;895.5387975192781;896.708569714842;863.9179277968583;888.8355654203993;894.2532984957568;901.3059943843236;904.1726819959729;919.7516670498961;942.7737343037655;950.6102497975832;955.2787645327768;961.9947155222809;940.0787228516092;947.7204224753714;953.0231512699469;954.0173621170205;955.5986485675963;692.9099217101794;699.2168770976488;706.3748582504469;708.2032713197652;714.7141143542573;14215.786763198561;14516.201608911506;14581.927090364481;14699;14713.117212967256;10198.694039178836;12561.057920655987;12599.685007874876;12812.55156069533;12890;9802.9509852451;10011.199104071657;10025.498725063717;10026.69919902404;10305;3464.359093567698;3487.6512348765173;3498.807565583892;3522.101864024683;3616.2948225096115;78161;80883.5955820223;83409.58295208485;83491.58254208691;83807.90480237982;9370.484623345645;9406.19604263013;9467.715968520955;9640.71077867665;9842.015798420101;20644.793552064286;21079.26222582202;21131.471713206985;21422.46443838885;21427.46431339229;6061.818145455643;7284.635768211674;7330.193678695339;7377.963110184414;7531.887021694679;3992.9032772506225;4015.257177422186;4018.6985976051915;4056.8782936511952;4113.300738874398;3562.87529936451;3568.357695614762;3608.278344331144;3612.87354942581;3617.5839778425293;645.8514541655352;654.306435178712;656.1568384625829;666.1140682891839;671.1007250284642;487.35912275357794;508.9618278629118;527.0092226614017;551.9347659018133;555.0148486436607;6826.146731658543;7349.30181632744;8202.26179643835;8244.258016778518;8377.664893404195;490.4800911034315;564.5173376762891;597.5070566782422;601.1703848688782;602.524006035236;3370.7134893533835;3373.6842631373784;3713.546263151106;3769.566499852552;3891.5135608048995;82839.58580207061;83796.48610541693;91991.08008919825;94358.52820735853;94630.0536994635;72355.19112022137;74054;74056.62971685106;74362;75996.24003760002;49891.750541247064;64664.70670586656;65462.99999999905;65817.01274480886;65841;7741.341985931033;7893.052833659997;7932.563708996061;7936.404769642185;7961.203879611992;48564.3002494911;49723;49877.25429609946;50778.74610626923;51253.97492050213;57941;58776.355064023075;61365.386346135965;63763;65298;10168;10797.524121970222;10820.729481763019;10843.783124337311;11262;9814.871289801478;10028.240160690748;11730.413479326171;11741.47163377633;12006.399680016139;11186.83219751688;11297.661070167907;11456.861379241782;11490.976747868765;11509.827352589551;11361.886381136082;11389.202755807346;11630.302181869114;11891.345975971404;12025.939870300592;11024.944875275572;11341;11577.6526704199;11663.066954643438;11704.180707350404;8641.308695304486;9342.673006444742;9513.476758778334;9723.124918757347;9740.853887191839;9124.361294709306;9449.858252126362;9664.516774161404;9685.031496850259;9688 09:51:25 INFO - PROCESS | 2338 | __end_tp_report 09:51:25 INFO - PROCESS | 2338 | __start_cc_report 09:51:25 INFO - PROCESS | 2338 | _x_x_mozilla_cycle_collect,361 09:51:25 INFO - PROCESS | 2338 | __end_cc_report 09:51:25 INFO - PROCESS | 2338 | __startTimestamp1460047885186__endTimestamp 09:51:25 INFO - PROCESS | 2338 | 09:51:25 INFO - PROCESS | 2338 | ------- Summary: start ------- 09:51:25 INFO - PROCESS | 2338 | Number of tests: 6 09:51:25 INFO - PROCESS | 2338 | 09:51:25 INFO - PROCESS | 2338 | [#0] dojo.html Cycles:165 Average:5679.99 Median:5880.38 stddev:768.78 (13.1%) stddev-sans-first:748.71 09:51:25 INFO - PROCESS | 2338 | Values: 3330.5 3398.8 3479.5 3497.4 3518.2 5709.0 5745.1 5747.7 5772.4 5775.9 5623.6 5629.8 5638.3 5731.3 5859.7 5096.4 5162.8 5192.5 5212.6 5245.0 441.9 5092.1 5186.4 5209.3 5219.8 5179.9 5182.8 5202.4 5215.3 5216.7 5203.6 5221.4 5222.1 5240.7 5265.6 5111.4 5113.7 5189.2 5200.1 5205.0 5604.8 5632.5 5676.3 5681.9 5728.0 6127.0 6188.5 6278.0 6287.6 6295.7 6171.4 6232.4 6278.1 6284.2 6287.7 5808.6 5846.2 5852.1 5857.9 5880.4 6182.5 6211.9 6262.4 6267.7 6276.7 5020.7 5045.5 5101.8 5200.7 6220.0 6209.0 6237.5 6261.0 6274.8 6288.2 4971.0 6130.1 6135.2 6188.2 6199.3 4869.9 6248.8 6249.8 6250.9 6293.0 4929.7 4935.7 4938.0 4941.9 4983.9 4336.7 4362.5 4380.7 4452.2 4512.6 5617.8 5694.0 5704.2 5726.3 5756.0 6218.9 6267.1 6278.3 6282.7 6291.2 5163.6 5619.5 5633.1 5730.1 5741.4 5316.8 5385.2 5399.0 5412.6 5414.6 6286.3 6314.5 6316.4 6320.4 6451.7 6143.0 6171.9 6220.7 6260.1 6280.6 6255.1 6256.8 6288.8 6310.7 6444.8 6218.9 6265.4 6268.5 6269.5 6291.1 6158.3 6196.8 6239.6 6247.1 6247.5 5990.6 6010.7 6151.4 6151.4 6189.0 5314.7 6182.2 6192.8 6194.6 6207.2 5134.9 5998.4 6050.3 6054.3 6106.2 6132.3 6147.9 6192.4 6197.3 6243.2 5892.1 5983.1 6054.5 6096.9 6097.1 09:51:25 INFO - PROCESS | 2338 | 09:51:25 INFO - PROCESS | 2338 | [#1] ext.html Cycles:180 Average:61794.47 Median:38073.81 stddev:130006.23 (341.5%) stddev-sans-first:130289.34 09:51:25 INFO - PROCESS | 2338 | Values: 450.4 500.7 583.6 589.7 632.7 33428.5 38190.2 38269.4 38338.4 38450.8 39223.8 39275.4 39641.8 39729.2 39822.8 9301.3 9461.6 9563.0 9577.3 9591.8 9504.3 9511.7 9604.5 9606.9 9641.1 9590.8 9642.0 9663.4 9669.3 9710.3 9565.2 9592.9 9605.3 9662.2 9677.5 9503.2 9664.6 9675.5 9681.5 9686.0 37748.6 37998.8 38148.8 38346.6 38453.0 2758.0 3038.5 3066.5 3304.0 3359.5 26404.2 27385.6 27762.2 27768.0 28091.2 2714.0 2749.2 2806.5 2857.2 2866.4 422691.0 424564.0 425087.0 425753.0 425766.0 45095.5 45523.0 59358.7 61001.7 61281.1 45192.5 46408.3 46489.1 46549.3 46671.1 13693.5 15853.1 16048.9 16161.8 16175.9 12475.4 12715.6 12923.4 12974.4 12987.4 14323.9 14345.7 14584.3 14591.0 14663.9 6188.5 6267.9 6280.7 6322.9 6352.5 930.7 955.9 1069.3 1096.5 1147.0 24412.0 25055.7 29032.4 29319.4 29619.0 991.5 1048.7 1094.4 1104.3 1121.8 14252.9 14253.2 14531.3 14550.5 14574.7 528239.0 530096.0 534777.0 536461.0 536950.0 56955.0 57065.0 57784.7 58046.4 58096.0 1381.5 1420.3 1458.5 1461.3 1464.9 24671.1 28501.6 28550.1 28983.7 29151.6 37470.1 45426.0 49214.3 49795.3 49921.0 497809.0 499632.0 501066.0 501243.0 501841.0 33026.5 33285.8 33458.3 33770.3 34005.3 44579.6 45669.9 45688.5 45848.0 46102.0 36396.8 36754.0 37005.4 37310.8 37617.2 30383.0 34670.5 36681.3 36814.8 37129.6 31332.9 36127.6 36642.6 36972.3 37221.0 30270.5 31623.0 32524.7 32940.8 32948.0 19487.9 23543.4 23825.4 23953.6 24230.5 09:51:25 INFO - PROCESS | 2338 | 09:51:25 INFO - PROCESS | 2338 | [#2] jquery.html Cycles:180 Average:33890.45 Median:26930.93 stddev:92999.58 (345.3%) stddev-sans-first:93226.38 09:51:25 INFO - PROCESS | 2338 | Values: 358.3 362.2 364.9 370.2 374.3 18701.7 19169.0 20495.9 20506.0 20574.1 19660.5 19690.1 19817.7 20003.7 20294.2 5664.2 5978.7 5981.9 5986.0 6017.8 3647.6 5832.4 6200.9 6642.9 6667.1 6482.5 6576.1 6596.4 6602.0 6617.8 7023.4 7370.4 7388.0 7399.5 7411.5 6871.5 6958.6 6999.5 7017.6 7062.5 25464.0 26422.9 26832.0 27029.9 27637.0 2204.9 2292.3 2355.8 2374.7 2523.8 14200.4 15016.7 15079.9 15428.5 15781.6 1797.6 1818.7 1858.7 1871.4 1903.5 111888.4 111978.4 114682.0 116516.4 119893.4 18684.7 18696.6 18921.9 18934.3 19275.1 22834.0 28631.4 28662.3 28713.1 28728.7 10512.7 10542.4 10896.2 10923.0 11001.4 7403.8 8396.1 8477.2 9371.5 9375.9 7715.5 7940.5 8460.4 8545.4 8624.8 2843.3 3297.6 3319.6 3326.1 3517.9 882.4 892.3 942.3 963.0 986.6 16611.8 18348.0 18853.8 20096.2 20660.0 938.8 954.4 990.3 994.4 1036.6 8759.8 9106.9 9970.8 10682.9 10743.2 510990.0 521250.0 549827.0 592238.0 610774.0 118791.4 119885.4 120338.2 121576.0 122395.0 1010.0 1038.1 1041.1 1047.1 1048.3 17386.1 17688.6 17925.6 18006.5 18398.5 37588.2 44597.3 45917.6 45925.0 46533.0 65290.0 65522.7 69320.0 69437.3 70261.0 7507.0 7542.7 7574.8 7671.4 7860.4 10854.9 11878.3 12050.2 12097.3 12211.5 10524.6 10617.2 10892.9 10900.0 10948.4 10268.8 10455.5 10555.6 10777.6 10917.7 10680.3 10723.5 10846.7 10938.2 11101.0 7513.5 7549.5 7612.6 7623.7 7836.0 9126.4 10626.5 10630.8 10853.3 10885.1 09:51:25 INFO - PROCESS | 2338 | 09:51:25 INFO - PROCESS | 2338 | [#3] mootools.html Cycles:180 Average:6059.72 Median:2746.92 stddev:3231.25 (117.6%) stddev-sans-first:3223.18 09:51:25 INFO - PROCESS | 2338 | Values: 1632.5 1635.9 1920.5 1994.6 2013.8 7941.3 8672.9 8679.3 8880.7 8880.9 7961.6 8671.6 8686.8 8789.5 8809.4 2069.2 2281.6 2458.5 2478.3 2488.1 1972.9 2252.2 2499.4 2516.7 2517.6 2060.2 2183.7 2301.5 2492.4 2505.3 2470.0 2473.6 2485.4 2487.3 2490.2 2465.8 2490.7 2494.3 2494.8 2503.4 8900.0 8902.9 8984.3 9004.7 9005.7 4976.4 5227.3 5373.4 5484.5 5560.4 3555.1 3635.0 3671.1 3684.2 3720.7 1015.4 1032.8 1034.1 1034.6 1034.7 11809.9 11907.0 12010.9 12020.9 12021.6 4781.5 4876.1 4909.5 4943.7 4959.2 10085.7 10140.6 10152.8 10164.6 10188.2 5429.8 5521.2 5538.4 5538.8 5546.1 4492.0 4874.5 4917.2 4963.9 4993.9 3861.2 3882.3 3956.3 3958.8 4035.8 1314.3 1316.9 1318.6 1327.5 1333.7 1079.3 1079.8 1289.4 1360.0 1385.8 7011.6 8301.7 8303.0 8315.9 8329.5 493.2 499.4 500.0 500.4 520.3 6189.7 6201.7 6253.4 6253.7 6261.2 10494.6 10855.7 10885.6 10892.5 11057.6 10481.1 10797.7 10826.6 10833.8 10868.6 7583.8 7912.6 8415.5 8484.4 8527.1 7676.9 7700.7 7852.6 7983.7 7998.6 8024.6 9519.2 9563.2 9648.7 9731.4 9835.2 9956.8 10012.4 10056.3 10086.0 6782.9 7268.1 7538.7 7577.5 7659.7 8329.1 8349.9 8368.2 8388.6 8394.9 7362.0 7552.7 7577.8 7587.1 7659.0 7392.8 7415.7 7487.8 7511.5 7594.2 7685.6 7800.9 7871.4 7876.6 7877.6 6685.1 6766.4 6774.3 6811.5 6825.4 7205.0 7249.4 7250.0 7270.5 7274.7 09:51:25 INFO - PROCESS | 2338 | 09:51:25 INFO - PROCESS | 2338 | [#4] prototype.html Cycles:180 Average:5979.81 Median:6723.60 stddev:1984.23 (29.5%) stddev-sans-first:1943.79 09:51:25 INFO - PROCESS | 2338 | Values: 319.9 329.2 331.3 333.2 336.6 6820.4 6862.4 6875.2 6877.6 6911.5 5632.7 6656.2 6670.3 6788.7 6857.0 4825.4 4877.3 4960.5 4979.7 5062.8 4987.2 4999.8 5021.9 5022.9 5031.4 4968.1 4971.8 4985.8 5013.4 5038.6 4269.1 4770.8 4973.8 4999.9 5008.4 3520.6 4296.9 4305.7 4308.5 4310.8 6293.4 6588.4 6588.5 6612.7 6687.1 5856.9 5902.0 5907.9 5912.9 5916.9 7369.6 7374.5 7389.4 7397.9 7414.0 3466.3 4173.5 4227.4 4339.0 4704.8 7278.6 7425.9 7708.7 7834.1 7859.3 3974.4 4648.6 4731.8 4755.2 4762.4 4861.2 4862.4 4864.3 4865.5 4882.7 5409.9 5732.1 5895.0 5901.7 5916.7 7420.8 7422.3 7428.9 7433.1 7462.8 1590.7 1636.9 1649.3 1667.1 1676.2 1047.2 1049.2 1067.5 1068.8 1069.9 5836.4 6676.9 6680.7 6711.4 6711.4 6149.4 7632.8 7638.8 7648.5 7668.4 6704.6 6735.8 6744.0 6765.8 6778.4 3309.7 3952.2 4054.0 4088.0 4096.9 6896.3 7638.8 7830.2 8074.7 8156.2 6940.9 7952.5 8038.8 8039.4 8087.5 8043.5 8073.6 8078.6 8082.0 8103.1 7484.7 7723.7 7770.8 7843.8 7856.1 7546.7 7615.3 7649.7 7658.6 7686.5 8045.6 8049.2 8067.5 8067.8 8073.4 4726.3 4777.9 4782.1 4791.9 4807.6 7494.2 7650.8 7755.5 7761.2 7775.8 7452.7 7454.7 7487.2 7498.8 7514.3 7464.0 7466.5 7476.6 7479.3 7557.4 6981.0 7261.6 7262.7 7282.2 7327.5 6040.9 7413.1 7454.4 7464.8 7465.8 7212.9 7267.8 7283.4 7292.3 7324.4 09:51:25 INFO - PROCESS | 2338 | 09:51:25 INFO - PROCESS | 2338 | [#5] yui.html Cycles:180 Average:17633.68 Median:3332.17 stddev:24637.76 (739.4%) stddev-sans-first:24673.81 09:51:25 INFO - PROCESS | 2338 | Values: 634.4 637.6 656.9 687.3 733.2 14410.7 14670.9 14672.4 14753.7 14790.9 13494.5 13561.0 13633.2 13661.1 13685.2 728.9 876.6 878.2 895.5 896.7 863.9 888.8 894.3 901.3 904.2 919.8 942.8 950.6 955.3 962.0 940.1 947.7 953.0 954.0 955.6 692.9 699.2 706.4 708.2 714.7 14215.8 14516.2 14581.9 14699.0 14713.1 10198.7 12561.1 12599.7 12812.6 12890.0 9803.0 10011.2 10025.5 10026.7 10305.0 3464.4 3487.7 3498.8 3522.1 3616.3 78161.0 80883.6 83409.6 83491.6 83807.9 9370.5 9406.2 9467.7 9640.7 9842.0 20644.8 21079.3 21131.5 21422.5 21427.5 6061.8 7284.6 7330.2 7378.0 7531.9 3992.9 4015.3 4018.7 4056.9 4113.3 3562.9 3568.4 3608.3 3612.9 3617.6 645.9 654.3 656.2 666.1 671.1 487.4 509.0 527.0 551.9 555.0 6826.1 7349.3 8202.3 8244.3 8377.7 490.5 564.5 597.5 601.2 602.5 3370.7 3373.7 3713.5 3769.6 3891.5 82839.6 83796.5 91991.1 94358.5 94630.1 72355.2 74054.0 74056.6 74362.0 75996.2 49891.8 64664.7 65463.0 65817.0 65841.0 7741.3 7893.1 7932.6 7936.4 7961.2 48564.3 49723.0 49877.3 50778.7 51254.0 57941.0 58776.4 61365.4 63763.0 65298.0 10168.0 10797.5 10820.7 10843.8 11262.0 9814.9 10028.2 11730.4 11741.5 12006.4 11186.8 11297.7 11456.9 11491.0 11509.8 11361.9 11389.2 11630.3 11891.3 12025.9 11024.9 11341.0 11577.7 11663.1 11704.2 8641.3 9342.7 9513.5 9723.1 9740.9 9124.4 9449.9 9664.5 9685.0 9688.0 09:51:25 INFO - PROCESS | 2338 | -------- Summary: end -------- 09:51:25 INFO - PROCESS | 2338 | 09:51:25 INFO - TEST-INFO | 2338: exit 0 09:51:25 INFO - TEST-OK | dromaeo_css | took 1110800ms 09:51:25 INFO - TEST-START | kraken 09:51:25 INFO - operating with platform_type : mac_ 09:51:25 INFO - Initialising browser for kraken test... 09:51:25 INFO - TEST-INFO | started process 2343 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmp7p8xpU/profile http://localhost:59154/getInfo.html) 09:51:27 INFO - PROCESS | 2343 | 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:28 INFO - PROCESS | 2343 | __metrics Screen width/height:1600/1200 09:51:28 INFO - PROCESS | 2343 | colorDepth:24 09:51:28 INFO - PROCESS | 2343 | Browser inner width/height: 1024/689 09:51:28 INFO - PROCESS | 2343 | __metrics 09:51:28 ERROR - PROCESS | 2343 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 09:51:28 INFO - TEST-INFO | 2343: exit 0 09:51:28 INFO - Browser initialized. 09:51:28 INFO - Running cycle 1/1 for kraken test... 09:51:28 INFO - TEST-INFO | started process 2346 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmp7p8xpU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:51:41 INFO - PROCESS | 2346 | RSS: Main: 246743040 09:51:41 INFO - PROCESS | 2346 | 09:51:43 INFO - PROCESS | 2346 | Cycle 1(1): loaded http://localhost:59154/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59154/tests/kraken/driver.html?testName=audio-beat-detection) 09:51:44 INFO - PROCESS | 2346 | RSS: Main: 258953216 09:51:44 INFO - PROCESS | 2346 | 09:51:47 INFO - PROCESS | 2346 | Cycle 1(1): loaded http://localhost:59154/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59154/tests/kraken/driver.html?testName=audio-dft) 09:51:47 INFO - PROCESS | 2346 | RSS: Main: 267931648 09:51:47 INFO - PROCESS | 2346 | 09:51:51 INFO - PROCESS | 2346 | Cycle 1(1): loaded http://localhost:59154/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59154/tests/kraken/driver.html?testName=audio-fft) 09:51:51 INFO - PROCESS | 2346 | RSS: Main: 271683584 09:51:51 INFO - PROCESS | 2346 | 09:51:53 INFO - PROCESS | 2346 | Cycle 1(1): loaded http://localhost:59154/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59154/tests/kraken/driver.html?testName=audio-oscillator) 09:51:54 INFO - PROCESS | 2346 | RSS: Main: 272470016 09:51:54 INFO - PROCESS | 2346 | 09:51:56 INFO - PROCESS | 2346 | Cycle 1(1): loaded http://localhost:59154/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59154/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:51:57 INFO - PROCESS | 2346 | RSS: Main: 274116608 09:51:57 INFO - PROCESS | 2346 | 09:51:59 INFO - PROCESS | 2346 | Cycle 1(1): loaded http://localhost:59154/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59154/tests/kraken/driver.html?testName=imaging-darkroom) 09:52:00 INFO - PROCESS | 2346 | RSS: Main: 274751488 09:52:00 INFO - PROCESS | 2346 | 09:52:03 INFO - PROCESS | 2346 | Cycle 1(1): loaded http://localhost:59154/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59154/tests/kraken/driver.html?testName=imaging-desaturate) 09:52:04 INFO - PROCESS | 2346 | RSS: Main: 274755584 09:52:04 INFO - PROCESS | 2346 | 09:52:07 INFO - PROCESS | 2346 | Cycle 1(1): loaded http://localhost:59154/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59154/tests/kraken/driver.html?testName=json-parse-financial) 09:52:07 INFO - PROCESS | 2346 | RSS: Main: 274890752 09:52:07 INFO - PROCESS | 2346 | 09:52:09 INFO - PROCESS | 2346 | Cycle 1(1): loaded http://localhost:59154/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59154/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:52:10 INFO - PROCESS | 2346 | RSS: Main: 274513920 09:52:10 INFO - PROCESS | 2346 | 09:52:12 INFO - PROCESS | 2346 | Cycle 1(1): loaded http://localhost:59154/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59154/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:52:12 INFO - PROCESS | 2346 | RSS: Main: 274194432 09:52:12 INFO - PROCESS | 2346 | 09:52:14 INFO - PROCESS | 2346 | Cycle 1(1): loaded http://localhost:59154/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59154/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:52:15 INFO - PROCESS | 2346 | RSS: Main: 274411520 09:52:15 INFO - PROCESS | 2346 | 09:52:18 INFO - PROCESS | 2346 | Cycle 1(1): loaded http://localhost:59154/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59154/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:52:18 INFO - PROCESS | 2346 | RSS: Main: 274432000 09:52:18 INFO - PROCESS | 2346 | 09:52:21 INFO - PROCESS | 2346 | Cycle 1(1): loaded http://localhost:59154/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59154/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:52:21 INFO - PROCESS | 2346 | RSS: Main: 274395136 09:52:21 INFO - PROCESS | 2346 | 09:52:23 INFO - PROCESS | 2346 | Cycle 1(1): loaded http://localhost:59154/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59154/tests/kraken/driver.html?testName=ai-astar) 09:52:23 INFO - PROCESS | 2346 | RSS: Main: 275935232 09:52:23 INFO - PROCESS | 2346 | 09:52:23 INFO - PROCESS | 2346 | __start_tp_report 09:52:23 INFO - PROCESS | 2346 | _x_x_mozilla_page_load 09:52:23 INFO - PROCESS | 2346 | _x_x_mozilla_page_load_details 09:52:23 INFO - PROCESS | 2346 | |i|pagename|runs| 09:52:23 INFO - PROCESS | 2346 | |0;ai-astar;126;156;171;117;117;128;115;114;95;169 09:52:23 INFO - PROCESS | 2346 | |1;audio-beat-detection;147;129;164;159;115;173;169;151;166;129 09:52:23 INFO - PROCESS | 2346 | |2;audio-dft;197;199;227;223;281;283;197;201;200;198 09:52:23 INFO - PROCESS | 2346 | |3;audio-fft;71;82;71;120;58;57;59;71;149;58 09:52:23 INFO - PROCESS | 2346 | |4;audio-oscillator;81;78;127;76;79;83;122;83;81;122 09:52:23 INFO - PROCESS | 2346 | |5;imaging-gaussian-blur;90;87;124;129;89;86;89;86;94;86 09:52:23 INFO - PROCESS | 2346 | |6;imaging-darkroom;98;95;96;95;119;151;95;96;100;96 09:52:23 INFO - PROCESS | 2346 | |7;imaging-desaturate;91;132;152;99;132;143;123;90;139;149 09:52:23 INFO - PROCESS | 2346 | |8;json-parse-financial;57;58;55;57;55;57;57;64;57;54 09:52:23 INFO - PROCESS | 2346 | |9;json-stringify-tinderbox;88;103;103;86;72;72;67;69;88;104 09:52:23 INFO - PROCESS | 2346 | |10;stanford-crypto-aes;86;87;85;85;83;86;82;94;113;84 09:52:23 INFO - PROCESS | 2346 | |11;stanford-crypto-ccm;142;134;129;122;142;122;110;112;161;135 09:52:23 INFO - PROCESS | 2346 | |12;stanford-crypto-pbkdf2;136;183;188;134;141;143;144;146;142;130 09:52:23 INFO - PROCESS | 2346 | |13;stanford-crypto-sha256-iterative;69;68;65;69;65;68;67;69;66;69 09:52:23 INFO - PROCESS | 2346 | __end_tp_report 09:52:23 INFO - PROCESS | 2346 | __start_cc_report 09:52:23 INFO - PROCESS | 2346 | _x_x_mozilla_cycle_collect,979 09:52:23 INFO - PROCESS | 2346 | __end_cc_report 09:52:23 INFO - PROCESS | 2346 | __startTimestamp1460047943881__endTimestamp 09:52:23 INFO - PROCESS | 2346 | 09:52:23 INFO - PROCESS | 2346 | ------- Summary: start ------- 09:52:23 INFO - PROCESS | 2346 | Number of tests: 14 09:52:23 INFO - PROCESS | 2346 | 09:52:23 INFO - PROCESS | 2346 | [#0] ai-astar Cycles:10 Average:130.80 Median:142.00 stddev:25.68 (18.1%) stddev-sans-first:27.18 09:52:23 INFO - PROCESS | 2346 | Values: 126.0 156.0 171.0 117.0 117.0 128.0 115.0 114.0 95.0 169.0 09:52:23 INFO - PROCESS | 2346 | 09:52:23 INFO - PROCESS | 2346 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:161.50 stddev:19.83 (12.3%) stddev-sans-first:21.00 09:52:23 INFO - PROCESS | 2346 | Values: 147.0 129.0 164.0 159.0 115.0 173.0 169.0 151.0 166.0 129.0 09:52:23 INFO - PROCESS | 2346 | 09:52:23 INFO - PROCESS | 2346 | [#2] audio-dft Cycles:10 Average:220.60 Median:212.00 stddev:34.14 (16.1%) stddev-sans-first:35.12 09:52:23 INFO - PROCESS | 2346 | Values: 197.0 199.0 227.0 223.0 281.0 283.0 197.0 201.0 200.0 198.0 09:52:23 INFO - PROCESS | 2346 | 09:52:23 INFO - PROCESS | 2346 | [#3] audio-fft Cycles:10 Average:79.60 Median:65.00 stddev:30.81 (47.4%) stddev-sans-first:32.52 09:52:23 INFO - PROCESS | 2346 | Values: 71.0 82.0 71.0 120.0 58.0 57.0 59.0 71.0 149.0 58.0 09:52:23 INFO - PROCESS | 2346 | 09:52:23 INFO - PROCESS | 2346 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:80.00 stddev:21.18 (26.5%) stddev-sans-first:21.99 09:52:23 INFO - PROCESS | 2346 | Values: 81.0 78.0 127.0 76.0 79.0 83.0 122.0 83.0 81.0 122.0 09:52:23 INFO - PROCESS | 2346 | 09:52:23 INFO - PROCESS | 2346 | [#5] imaging-gaussian-blur Cycles:10 Average:96.00 Median:88.00 stddev:16.30 (18.5%) stddev-sans-first:17.15 09:52:23 INFO - PROCESS | 2346 | Values: 90.0 87.0 124.0 129.0 89.0 86.0 89.0 86.0 94.0 86.0 09:52:23 INFO - PROCESS | 2346 | 09:52:23 INFO - PROCESS | 2346 | [#6] imaging-darkroom Cycles:10 Average:104.10 Median:95.50 stddev:18.02 (18.9%) stddev-sans-first:18.97 09:52:23 INFO - PROCESS | 2346 | Values: 98.0 95.0 96.0 95.0 119.0 151.0 95.0 96.0 100.0 96.0 09:52:23 INFO - PROCESS | 2346 | 09:52:23 INFO - PROCESS | 2346 | [#7] imaging-desaturate Cycles:10 Average:125.00 Median:150.50 stddev:23.53 (15.6%) stddev-sans-first:21.50 09:52:23 INFO - PROCESS | 2346 | Values: 91.0 132.0 152.0 99.0 132.0 143.0 123.0 90.0 139.0 149.0 09:52:23 INFO - PROCESS | 2346 | 09:52:23 INFO - PROCESS | 2346 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:57.00 stddev:2.73 (4.8%) stddev-sans-first:2.89 09:52:23 INFO - PROCESS | 2346 | Values: 57.0 58.0 55.0 57.0 55.0 57.0 57.0 64.0 57.0 54.0 09:52:23 INFO - PROCESS | 2346 | 09:52:23 INFO - PROCESS | 2346 | [#9] json-stringify-tinderbox Cycles:10 Average:85.20 Median:72.00 stddev:14.70 (20.4%) stddev-sans-first:15.56 09:52:23 INFO - PROCESS | 2346 | Values: 88.0 103.0 103.0 86.0 72.0 72.0 67.0 69.0 88.0 104.0 09:52:23 INFO - PROCESS | 2346 | 09:52:23 INFO - PROCESS | 2346 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:85.50 stddev:9.20 (10.8%) stddev-sans-first:9.72 09:52:23 INFO - PROCESS | 2346 | Values: 86.0 87.0 85.0 85.0 83.0 86.0 82.0 94.0 113.0 84.0 09:52:23 INFO - PROCESS | 2346 | 09:52:23 INFO - PROCESS | 2346 | [#11] stanford-crypto-ccm Cycles:10 Average:130.90 Median:134.50 stddev:15.40 (11.5%) stddev-sans-first:15.80 09:52:23 INFO - PROCESS | 2346 | Values: 142.0 134.0 129.0 122.0 142.0 122.0 110.0 112.0 161.0 135.0 09:52:23 INFO - PROCESS | 2346 | 09:52:23 INFO - PROCESS | 2346 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.70 Median:143.50 stddev:20.04 (14.0%) stddev-sans-first:20.72 09:52:23 INFO - PROCESS | 2346 | Values: 136.0 183.0 188.0 134.0 141.0 143.0 144.0 146.0 142.0 130.0 09:52:23 INFO - PROCESS | 2346 | 09:52:23 INFO - PROCESS | 2346 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.50 stddev:1.65 (2.4%) stddev-sans-first:1.66 09:52:23 INFO - PROCESS | 2346 | Values: 69.0 68.0 65.0 69.0 65.0 68.0 67.0 69.0 66.0 69.0 09:52:23 INFO - PROCESS | 2346 | -------- Summary: end -------- 09:52:23 INFO - PROCESS | 2346 | 09:52:24 INFO - TEST-INFO | 2346: exit 0 09:52:24 INFO - TEST-OK | kraken | took 58825ms 09:52:24 INFO - SUITE-END | took 1169s 09:52:24 INFO - Completed test suite (00:19:29) 09:52:24 INFO - javascript benchmark 09:52:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3330.4837750148727, 3398.796072235666, 3479.5476588043553, 3497.4404095344735, 3518.208403109299, 5709.029464990951, 5745.052066409037, 5747.655140691561, 5772.365039845619, 5775.855603609906, 5623.606347555673, 5629.845881594274, 5638.323401191852, 5731.254936858202, 5859.7070146492715, 5096.362954630662, 5162.793488260484, 5192.506711862386, 5212.556932660709, 5244.973775131138, 441.9089055543568, 5092.134337162673, 5186.429492755794, 5209.32278803755, 5219.825539253676, 5179.948200517984, 5182.792688292464, 5202.4277329493725, 5215.348081489814, 5216.739163041871, 5203.635745497817, 5221.39953905302, 5222.112240919015, 5240.685558866442, 5265.631405801595, 5111.437741848394, 5113.718745468997, 5189.2475591039465, 5200.115980283361, 5205.0, 5604.775808967636, 5632.549396048306, 5676.262085928803, 5681.886362272731, 5728.0238317780295, 6126.969365153191, 6188.535859810532, 6277.968610156966, 6287.622742635456, 6295.685215739195, 6171.413715697002, 6232.376762323776, 6278.089676996809, 6284.151639528651, 6287.6856157192415, 5808.564357673149, 5846.181534585162, 5852.122181672783, 5857.912131318076, 5880.382559831241, 6182.474489668339, 6211.9068213976825, 6262.436380725757, 6267.6866156691985, 6276.686165691788, 5020.748962551857, 5045.495450454925, 5101.795928162906, 5200.6619569727845, 6220.0, 6209.0, 6237.4698150657705, 6260.968695156586, 6274.780382686584, 6288.182536270256, 4971.0, 6130.111133885562, 6135.232666670055, 6188.164597779332, 6199.3490683478485, 4869.9026019480125, 6248.812535623939, 6249.75000999964, 6250.9062364064575, 6293.0, 4929.679570827885, 4935.654504184673, 4938.0, 4941.925871111936, 4983.8504844854715, 4336.739795612273, 4362.498312694081, 4380.67144964129, 4452.2431186697695, 4512.638988880882, 5617.8033768817895, 5694.003549378842, 5704.22992895962, 5726.284214473191, 5756.02147634903, 6218.9378106219265, 6267.059941008794, 6278.340774218733, 6282.717277722422, 6291.213598300213, 5163.586913046947, 5619.466150715675, 5633.126865335879, 5730.1404789281105, 5741.397153298927, 5316.787328506816, 5385.165299378603, 5398.973005135028, 5412.648177868505, 5414.593905457028, 6286.339934306923, 6314.494840412756, 6316.399942005502, 6320.431161195606, 6451.677416129175, 6142.959235178615, 6171.938280617136, 6220.657863817352, 6260.092286618324, 6280.591761535486, 6255.061740738925, 6256.786237261826, 6288.779892703734, 6310.7475700971445, 6444.8388790280615, 6218.875622487615, 6265.4361107500545, 6268.498520118288, 6269.49844012487, 6291.087792270187, 6158.3225845157895, 6196.752129914933, 6239.594426362272, 6247.0629405589525, 6247.468965137832, 5990.64056156632, 6010.678567159393, 6151.3541078186145, 6151.384861513813, 6189.0097584386285, 5314.707691077027, 6182.196314479269, 6192.845178870384, 6194.5973511721595, 6207.193064901534, 5134.9486505135965, 5998.430149135826, 6050.273967123973, 6054.3340232575265, 6106.236720409949, 6132.264128304632, 6147.877042459037, 6192.442680158807, 6197.349278325711, 6243.157173781481, 5892.116182572477, 5983.132445795248, 6054.455099040932, 6096.878062438637, 6097.146399504161], "unit": "score", "name": "dojo.html", "value": 5634.403912863707}, {"lowerIsBetter": false, "replicates": [450.3919708393669, 500.7095884387057, 583.5944018906862, 589.7320760365211, 632.6710110742413, 33428.4985725214, 38190.23619527608, 38269.42595861064, 38338.424923626095, 38450.84647460577, 39223.803880980624, 39275.41086883699, 39641.801790991005, 39729.205415891665, 39822.80088599553, 9301.348905576613, 9461.574229159703, 9562.952185239099, 9577.329586928918, 9591.760205994837, 9504.334696571243, 9511.714648560554, 9604.471754053524, 9606.855897161548, 9641.13229809317, 9590.80818383632, 9641.951790241039, 9663.4201947883, 9669.323147379686, 9710.271729620272, 9565.234781217521, 9592.904070959341, 9605.279604029725, 9662.227021838236, 9677.516124193797, 9503.192228660571, 9664.565094570762, 9675.516224188832, 9681.467519286436, 9686.0, 37748.62251377478, 37998.81000595007, 38148.80925595354, 38346.616533834866, 38453.0, 2757.9724202758116, 3038.453078445879, 3066.509358502629, 3303.9834800825843, 3359.5296658467832, 26404.20787376382, 27385.589216161774, 27762.167134985983, 27768.02811901594, 28091.157265282076, 2713.9592906106423, 2749.2164733050986, 2806.494830930432, 2857.171420288114, 2866.383727498577, 422691.0, 424564.0, 425087.0, 425753.0, 425766.0, 45095.54904450979, 45523.0, 59358.703206484555, 61001.69499152476, 61281.08078378828, 45192.548074519495, 46408.303875441896, 46489.07021859611, 46549.30176047362, 46671.06657866824, 13693.520726774515, 15853.128077955593, 16048.919755401148, 16161.838381616033, 16175.94856334358, 12475.376231188404, 12715.618531444072, 12923.353832308347, 12974.416151273215, 12987.350632468339, 14323.856761432253, 14345.713085738436, 14584.343704533321, 14591.0, 14663.853361466463, 6188.504919606511, 6267.874642507124, 6280.7487700491465, 6322.9051564226575, 6352.460040896483, 930.7254359963827, 955.8518429643277, 1069.3102948598112, 1096.4846522134585, 1146.9541218351173, 24412.023519059392, 25055.749442505705, 29032.419351613273, 29319.413611727647, 29619.0, 991.5141580625442, 1048.6681913969217, 1094.4035500652165, 1104.2932523185168, 1121.7812526557243, 14252.857471425154, 14253.216073115871, 14531.273436328142, 14550.4907328243, 14574.708505829823, 528239.0, 530096.0, 534777.0, 536461.0, 536950.0, 56955.0, 57065.0, 57784.71107644435, 58046.4195358041, 58096.0, 1381.530279704905, 1420.3040510150158, 1458.4530800949644, 1461.3423959218394, 1464.9047811892192, 24671.136510222055, 28501.572476412457, 28550.143495695163, 28983.7101628981, 29151.562726559543, 37470.06324841901, 45426.0, 49214.26178607252, 49795.25307120324, 49921.0, 497809.0, 499632.0, 501066.0, 501242.97514050244, 501841.0, 33026.504602431465, 33285.833570831994, 33458.33083338368, 33770.324593508485, 34005.319893602486, 44579.55420445884, 45669.85825354393, 45688.54311456976, 45848.0, 46102.0, 36396.818015909754, 36754.0, 37005.44491832571, 37310.813445932596, 37617.24765504729, 30383.0, 34670.47994280138, 36681.266374672894, 36814.8159259202, 37129.62870371262, 31332.90334838361, 36127.638723613476, 36642.633573664985, 36972.26055478929, 37221.0, 30270.54594181045, 31623.0, 32524.674753252166, 32940.835295823366, 32948.0, 19487.92670695247, 23543.41141471477, 23825.404364890324, 23953.64069538993, 24230.51538969246], "unit": "score", "name": "ext.html", "value": 18828.36875857055}, {"lowerIsBetter": false, "replicates": [358.31204088150747, 362.16701586351394, 364.9470826730124, 370.189285464832, 374.34115955917576, 18701.71947420788, 19169.0, 20495.897520512415, 20506.0, 20574.074166662518, 19660.508487287825, 19690.11394487248, 19817.702734458995, 20003.699944500808, 20294.188232470682, 5664.20701101846, 5978.701064946736, 5981.850453738648, 5985.970070149643, 6017.789377371793, 3647.598764135943, 5832.358440571534, 6200.945839207346, 6642.900356494656, 6667.066610674509, 6482.481401487869, 6576.112224849632, 6596.43930265928, 6602.009698545208, 6617.834554136137, 7023.403010744068, 7370.373518250955, 7387.963060184691, 7399.519031263005, 7411.48119631626, 6871.484638652071, 6958.617276049815, 6999.545029573062, 7017.57894526325, 7062.54093483927, 25464.0, 26422.867885660642, 26832.0, 27029.864850675818, 27637.0, 2204.889755512218, 2292.3008482412856, 2355.7644235576304, 2374.662293513053, 2523.8107141964424, 14200.360983755756, 15016.699666006618, 15079.944403891732, 15428.460003899809, 15781.60545986348, 1797.6494583556212, 1818.6635472437642, 1858.7304840798145, 1871.3543827379533, 1903.5146037760421, 111888.4405577967, 111978.44010779895, 114682.0, 116516.41741791237, 119893.40053299765, 18684.719729204073, 18696.626067478574, 18921.905390473235, 18934.337298194496, 19275.132619032178, 22834.0, 28631.427371452453, 28662.28344291368, 28713.133646312923, 28728.712712872602, 10512.737181570523, 10542.420166890895, 10896.18278629106, 10923.0, 11001.394923279297, 7403.8149046274275, 8396.118407567117, 8477.237048665527, 9371.48456834867, 9375.859362109573, 7715.498492597963, 7940.523568585903, 8460.407771455939, 8545.359098067669, 8624.78438039054, 2843.317603775079, 3297.554830097954, 3319.5850518685165, 3326.101952472867, 3517.8944631661093, 882.3955590420583, 892.2906289499863, 942.2791564453199, 962.9711108666751, 986.5511192407438, 16611.754118441164, 18348.0, 18853.82680381543, 20096.196152154043, 20659.967001649857, 938.7934654376027, 954.4178051388648, 990.2919412620012, 994.3735446668552, 1036.5542816588938, 8759.824803503894, 9106.86339704905, 9970.750731231778, 10682.946585267024, 10743.194260430499, 510990.0, 521250.0, 549827.0, 592238.0, 610774.0, 118791.40604296923, 119885.40057299657, 120338.19492707617, 121576.0, 122395.0, 1009.9697009089739, 1038.0999505195448, 1041.0526420957044, 1047.0733849716405, 1048.308116643012, 17386.13069346553, 17688.55778605545, 17925.641487170444, 18006.459806205836, 18398.540036499195, 37588.248235034596, 44597.33104003378, 45917.622471325914, 45925.0, 46533.0, 65290.0, 65522.672386637765, 69320.0, 69437.30562694308, 70261.0, 7506.962465187639, 7542.6605802740105, 7574.772756817304, 7671.38628909697, 7860.449768516378, 10854.945725271324, 11878.346690932081, 12050.156489045683, 12097.347552638565, 12211.511539538318, 10524.631637892637, 10617.203709721647, 10892.945535272273, 10900.0, 10948.397838118979, 10268.794624107626, 10455.529501172314, 10555.63055293061, 10777.568897244022, 10917.727056823644, 10680.305780124267, 10723.463826808473, 10846.67459976202, 10938.179636527133, 11101.000909918146, 7513.4740568159705, 7549.547027178167, 7612.619369031416, 7623.656935437808, 7836.0, 9126.361154719107, 10626.468676566295, 10630.8405373921, 10853.34879907208, 10885.074768644754], "unit": "score", "name": "jquery.html", "value": 10257.289876313598}, {"lowerIsBetter": false, "replicates": [1632.5428879913625, 1635.8773092018098, 1920.5006698258449, 1994.6409646263685, 2013.7885522020179, 7941.28528432441, 8672.8699069514, 8679.349048821348, 8880.689175878846, 8880.911190888097, 7961.60191990401, 8671.566421678923, 8686.782830429242, 8789.516576588285, 8809.38334316598, 2069.203356707671, 2281.6007198740194, 2458.4591389894194, 2478.3432390416556, 2488.091846476032, 1972.8557436686688, 2252.245497758253, 2499.4126380300613, 2516.6854143232094, 2517.6349429332736, 2060.1965233558926, 2183.6942828004094, 2301.5166814968793, 2492.3519884829893, 2505.260948020329, 2469.987650061756, 2473.6042233242683, 2485.391079185593, 2487.345914966545, 2490.1906880263987, 2465.778079972793, 2490.651308816767, 2494.2641920633455, 2494.750524947509, 2503.4242124311327, 8899.955500222522, 8902.910970890272, 8984.28125749945, 9004.684836030772, 9005.729828105103, 4976.402831660188, 5227.294315267428, 5373.35519737634, 5484.533814625762, 5560.443955604448, 3555.1289933966345, 3634.963650363489, 3671.1372827385544, 3684.207895302496, 3720.665140137374, 1015.441507171053, 1032.7521394865178, 1034.1468288661883, 1034.6378767431413, 1034.7154532503546, 11809.881901180965, 11907.0, 12010.879891201064, 12020.91811736939, 12021.639350819489, 4781.545753153445, 4876.122297986326, 4909.5090490950615, 4943.703377797344, 4959.181735013754, 10085.697429076992, 10140.594376224868, 10152.796944061078, 10164.593416263415, 10188.235882308709, 5429.809956651498, 5521.171824226398, 5538.418466061086, 5538.778448862081, 5546.112621980464, 4491.955080449219, 4874.488178741252, 4917.164082106051, 4963.925541116886, 4993.875153121201, 3861.1698484825897, 3882.2623701496627, 3956.287868183697, 3958.802059896994, 4035.8183881725395, 1314.3428285857071, 1316.8683131686755, 1318.641798947086, 1327.502186679995, 1333.6532501549473, 1079.3200283821143, 1079.8056349857102, 1289.4133169407896, 1359.9800149887585, 1385.7990591364196, 7011.649417529103, 8301.709440169565, 8303.04514980785, 8315.916840831514, 8329.458585191944, 493.2428721911848, 499.4381321013859, 499.95750361219706, 500.4220125754759, 520.3079903728033, 6189.721462534197, 6201.720922558496, 6253.437190652772, 6253.6873156342, 6261.154744109578, 10494.580216791395, 10855.728606784893, 10885.564577416973, 10892.509837057192, 11057.557697692164, 10481.056704896444, 10797.676069717922, 10826.62106826273, 10833.78332433347, 10868.565257389615, 7583.7724868254045, 7912.6152923238205, 8415.45299555527, 8484.43038037965, 8527.062023177445, 7676.923230767844, 7700.653470593725, 7852.568108753845, 7983.720569780262, 7998.600069996593, 8024.598770061357, 9519.190868775955, 9563.234941204826, 9648.71053868385, 9731.416115032838, 9835.213182945205, 9956.751081223027, 10012.44931528773, 10056.29605927578, 10086.0, 6782.93217067823, 7268.0914885639295, 7538.660760265691, 7577.469577129548, 7659.731909383145, 8329.083800781787, 8349.916500834914, 8368.163183681583, 8388.58057097155, 8394.916050839658, 7362.0, 7552.66013029426, 7577.760768213755, 7587.089549254125, 7659.042619672541, 7392.778216653509, 7415.740449084256, 7487.775366739006, 7511.549307041595, 7594.202608726005, 7685.577293248925, 7800.92199078002, 7871.370290376871, 7876.606169691607, 7877.606119694107, 6685.097511836035, 6766.4248538874745, 6774.288699686659, 6811.4550835934, 6825.35159159879, 7204.9639751800905, 7249.42004639617, 7250.0, 7270.527415717961, 7274.709011639475], "unit": "score", "name": "mootools.html", "value": 4843.858173827421}, {"lowerIsBetter": false, "replicates": [319.9456092464281, 329.2378144595262, 331.3207923756299, 333.21195372943, 336.61457631012485, 6820.352066553675, 6862.382385585296, 6875.243723190445, 6877.552959057658, 6911.516193866431, 5632.746526406311, 6656.234533028691, 6670.332966703328, 6788.660566971644, 6856.965715171417, 4825.372701548794, 4877.292792545079, 4960.479149689285, 4979.7261150636705, 5062.797488100481, 4987.17711577591, 4999.825041115335, 5021.899562008758, 5022.924656130161, 5031.396232452111, 4968.056069346812, 4971.776270067856, 4985.800567977277, 5013.373328333958, 5038.571721403685, 4269.146170765844, 4770.833020844271, 4973.825916092956, 4999.925001124986, 5008.424031236418, 3520.5775306963073, 4296.914061718748, 4305.655547556188, 4308.46144231971, 4310.849120280806, 6293.37066293367, 6588.374104460068, 6588.538802283842, 6612.702428390734, 6687.097241872334, 5856.882862342772, 5902.0, 5907.852303692399, 5912.852178695524, 5916.911246331309, 7369.557826530426, 7374.483786134972, 7389.371903388218, 7397.926020739777, 7414.0, 3466.30673865228, 4173.499180098377, 4227.4292970448905, 4338.978305108454, 4704.764761761932, 7278.563286202845, 7425.925740742631, 7708.653110610036, 7834.0990786059765, 7859.292663660241, 3974.3839704845795, 4648.628109751212, 4731.810727570859, 4755.2153894607, 4762.404699412574, 4861.246506791453, 4862.367892173995, 4864.318995340655, 4865.537773911544, 4882.658213924991, 5409.891802163935, 5732.054211055212, 5895.0, 5901.734421951022, 5916.674582897982, 7420.814479638052, 7422.294881986203, 7428.922806193072, 7433.070866141732, 7462.776116716507, 1590.7295759720876, 1636.885418020727, 1649.2578339747163, 1667.132811251406, 1676.1535424610738, 1047.1936608811325, 1049.21833234241, 1067.4876059491332, 1068.834330678746, 1069.8769641491172, 5836.445537673914, 6676.899846502306, 6680.732770689216, 6711.362420570038, 6711.395974362331, 6149.41580549847, 7632.80917977055, 7638.847223055508, 7648.464607477535, 7668.38652907766, 6704.564203326768, 6735.797926062226, 6744.0, 6765.830854228684, 6778.423833974069, 3309.7352211822995, 3952.1700442906736, 4053.959460405358, 4087.9795601021806, 4096.897577560585, 6896.310368963063, 7638.847223055508, 7830.177831327743, 8074.677012919535, 8156.184381561915, 6940.930590694129, 7952.483088599222, 8038.758837234892, 8039.437239393186, 8087.47431416956, 8043.517388956681, 8073.5963201838495, 8078.596070196467, 8081.959590202011, 8103.068147162916, 7484.663190156565, 7723.691052357843, 7770.844583108194, 7843.764687059397, 7856.057273127261, 7546.660535234095, 7615.276548727862, 7649.6557654904545, 7658.6170691464085, 7686.500377475446, 8045.637946292314, 8049.154838741848, 8067.515949043076, 8067.83864322722, 8073.35413166957, 4726.338312636302, 4777.928331074967, 4782.139214941344, 4791.856244312677, 4807.591354734886, 7494.17564067963, 7650.8087297818, 7755.495892766952, 7761.223877612194, 7775.844483110419, 7452.739154129579, 7454.6645400956, 7487.176410594721, 7498.775036748906, 7514.323710866049, 7464.0, 7466.514676546007, 7476.626168691435, 7479.252074792477, 7557.395408367427, 6980.965095174492, 7261.564306141649, 7262.745803896838, 7282.235365286569, 7327.4504412168235, 6040.939590604038, 7413.1104267488245, 7454.366378857858, 7464.776056718307, 7465.776026719207, 7212.89180662301, 7267.781966540801, 7283.380912622486, 7292.34368906801, 7324.4140468763435], "unit": "score", "name": "prototype.html", "value": 5308.55960419978}, {"lowerIsBetter": false, "replicates": [634.4068296143107, 637.6333608175299, 656.8865772515585, 687.2920593398611, 733.1605311917857, 14410.711785764292, 14670.926645366784, 14672.413103475861, 14753.704925901475, 14790.926045369784, 13494.46022159115, 13561.0, 13633.182009079437, 13661.112027718216, 13685.178889266626, 728.9234630363815, 876.6274333408276, 878.1876763993329, 895.5387975192781, 896.708569714842, 863.9179277968583, 888.8355654203993, 894.2532984957568, 901.3059943843236, 904.1726819959729, 919.7516670498961, 942.7737343037655, 950.6102497975832, 955.2787645327768, 961.9947155222809, 940.0787228516092, 947.7204224753714, 953.0231512699469, 954.0173621170205, 955.5986485675963, 692.9099217101794, 699.2168770976488, 706.3748582504469, 708.2032713197652, 714.7141143542573, 14215.786763198561, 14516.201608911506, 14581.927090364481, 14699.0, 14713.117212967256, 10198.694039178836, 12561.057920655987, 12599.685007874876, 12812.55156069533, 12890.0, 9802.9509852451, 10011.199104071657, 10025.498725063717, 10026.69919902404, 10305.0, 3464.359093567698, 3487.6512348765173, 3498.807565583892, 3522.101864024683, 3616.2948225096115, 78161.0, 80883.5955820223, 83409.58295208485, 83491.58254208691, 83807.90480237982, 9370.484623345645, 9406.19604263013, 9467.715968520955, 9640.71077867665, 9842.015798420101, 20644.793552064286, 21079.26222582202, 21131.471713206985, 21422.46443838885, 21427.46431339229, 6061.818145455643, 7284.635768211674, 7330.193678695339, 7377.963110184414, 7531.887021694679, 3992.9032772506225, 4015.257177422186, 4018.6985976051915, 4056.8782936511952, 4113.300738874398, 3562.87529936451, 3568.357695614762, 3608.278344331144, 3612.87354942581, 3617.5839778425293, 645.8514541655352, 654.306435178712, 656.1568384625829, 666.1140682891839, 671.1007250284642, 487.35912275357794, 508.9618278629118, 527.0092226614017, 551.9347659018133, 555.0148486436607, 6826.146731658543, 7349.30181632744, 8202.26179643835, 8244.258016778518, 8377.664893404195, 490.4800911034315, 564.5173376762891, 597.5070566782422, 601.1703848688782, 602.524006035236, 3370.7134893533835, 3373.6842631373784, 3713.546263151106, 3769.566499852552, 3891.5135608048995, 82839.58580207061, 83796.48610541693, 91991.08008919825, 94358.52820735853, 94630.0536994635, 72355.19112022137, 74054.0, 74056.62971685106, 74362.0, 75996.24003760002, 49891.750541247064, 64664.70670586656, 65462.99999999905, 65817.01274480886, 65841.0, 7741.341985931033, 7893.052833659997, 7932.563708996061, 7936.404769642185, 7961.203879611992, 48564.3002494911, 49723.0, 49877.25429609946, 50778.74610626923, 51253.97492050213, 57941.0, 58776.355064023075, 61365.386346135965, 63763.0, 65298.0, 10168.0, 10797.524121970222, 10820.729481763019, 10843.783124337311, 11262.0, 9814.871289801478, 10028.240160690748, 11730.413479326171, 11741.47163377633, 12006.399680016139, 11186.83219751688, 11297.661070167907, 11456.861379241782, 11490.976747868765, 11509.827352589551, 11361.886381136082, 11389.202755807346, 11630.302181869114, 11891.345975971404, 12025.939870300592, 11024.944875275572, 11341.0, 11577.6526704199, 11663.066954643438, 11704.180707350404, 8641.308695304486, 9342.673006444742, 9513.476758778334, 9723.124918757347, 9740.853887191839, 9124.361294709306, 9449.858252126362, 9664.516774161404, 9685.031496850259, 9688.0], "unit": "score", "name": "yui.html", "value": 6727.738415007334}], "name": "dromaeo_css", "value": 7570.550648393367}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [126.0, 156.0, 171.0, 117.0, 117.0, 128.0, 115.0, 114.0, 95.0, 169.0], "unit": "score", "name": "ai-astar", "value": 130.8}, {"lowerIsBetter": true, "replicates": [147.0, 129.0, 164.0, 159.0, 115.0, 173.0, 169.0, 151.0, 166.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 150.2}, {"lowerIsBetter": true, "replicates": [197.0, 199.0, 227.0, 223.0, 281.0, 283.0, 197.0, 201.0, 200.0, 198.0], "unit": "score", "name": "audio-dft", "value": 220.6}, {"lowerIsBetter": true, "replicates": [71.0, 82.0, 71.0, 120.0, 58.0, 57.0, 59.0, 71.0, 149.0, 58.0], "unit": "score", "name": "audio-fft", "value": 79.6}, {"lowerIsBetter": true, "replicates": [81.0, 78.0, 127.0, 76.0, 79.0, 83.0, 122.0, 83.0, 81.0, 122.0], "unit": "score", "name": "audio-oscillator", "value": 93.2}, {"lowerIsBetter": true, "replicates": [90.0, 87.0, 124.0, 129.0, 89.0, 86.0, 89.0, 86.0, 94.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 96.0}, {"lowerIsBetter": true, "replicates": [98.0, 95.0, 96.0, 95.0, 119.0, 151.0, 95.0, 96.0, 100.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 104.1}, {"lowerIsBetter": true, "replicates": [91.0, 132.0, 152.0, 99.0, 132.0, 143.0, 123.0, 90.0, 139.0, 149.0], "unit": "score", "name": "imaging-desaturate", "value": 125.0}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 55.0, 57.0, 55.0, 57.0, 57.0, 64.0, 57.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.1}, {"lowerIsBetter": true, "replicates": [88.0, 103.0, 103.0, 86.0, 72.0, 72.0, 67.0, 69.0, 88.0, 104.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 85.2}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 85.0, 85.0, 83.0, 86.0, 82.0, 94.0, 113.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.5}, {"lowerIsBetter": true, "replicates": [142.0, 134.0, 129.0, 122.0, 142.0, 122.0, 110.0, 112.0, 161.0, 135.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.9}, {"lowerIsBetter": true, "replicates": [136.0, 183.0, 188.0, 134.0, 141.0, 143.0, 144.0, 146.0, 142.0, 130.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.7}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 65.0, 69.0, 65.0, 68.0, 67.0, 69.0, 66.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.5}], "name": "kraken", "value": 1577.4000000000003}]} 09:52:24 INFO - Return code: 0 09:52:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:52:24 ERROR - # TBPL SUCCESS # 09:52:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:52:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:52:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:52:24 INFO - 2016-04-07 09:52:24.716 screenresolution[2351:29240] starting screenresolution argv=screenresolution get 09:52:24 INFO - 2016-04-07 09:52:24.718 screenresolution[2351:29240] Display 0: 1600x1200x32@60 09:52:24 INFO - 2016-04-07 09:52:24.724 screenresolution[2352:29243] starting screenresolution argv=screenresolution list 09:52:24 INFO - Available Modes on Display 0 09:52:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:52:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:52:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:52:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:52:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:52:24 INFO - Intel Iris: 09:52:24 INFO - Chipset Model: Intel Iris 09:52:24 INFO - Type: GPU 09:52:24 INFO - Bus: Built-In 09:52:24 INFO - VRAM (Dynamic, Max): 1536 MB 09:52:24 INFO - Vendor: Intel (0x8086) 09:52:24 INFO - Device ID: 0x0a2e 09:52:24 INFO - Revision ID: 0x0009 09:52:24 INFO - Displays: 09:52:24 INFO - Display: 09:52:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:52:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:52:24 INFO - Display Serial Number: 1600x1200 60 09:52:24 INFO - Main Display: Yes 09:52:24 INFO - Mirror: Off 09:52:24 INFO - Online: Yes 09:52:24 INFO - Rotation: Supported 09:52:24 INFO - Return code: 0 09:52:24 INFO - Running post-action listener: _resource_record_post_action 09:52:24 INFO - Running post-run listener: _resource_record_post_run 09:52:26 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 32768; Write bytes: 696508928; Read time: 1; Write time: 2341 09:52:26 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 383758848; Write bytes: 378287616; Read time: 28478; Write time: 668 09:52:26 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 24576; Write bytes: 300755968; Read time: 1; Write time: 1635 09:52:26 INFO - Running post-run listener: _upload_blobber_files 09:52:26 INFO - Blob upload gear active. 09:52:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:52:26 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:26 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:26 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:26 INFO - (blobuploader) - INFO - Open directory for files ... 09:52:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:52:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:52:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:52:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:52:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:52:27 INFO - (blobuploader) - INFO - Done attempting. 09:52:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:52:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:52:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:52:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:52:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:52:28 INFO - (blobuploader) - INFO - Done attempting. 09:52:28 INFO - (blobuploader) - INFO - Iteration through files over. 09:52:28 INFO - Return code: 0 09:52:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:52:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:52:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5d7c70a2e9a9059b855a563cbe598aa5053a1e19cc51abf36d0f30fcdd3b4d3e28035a18fa4d85e71149d14cf9880b17919a0e225c7f815288bd644d989dd6c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a3091f30af4d3e8d94525cc7a4892af19e392e1dce46ad6c47a072ee12249692edc66a05aa6b6bbd97dff6dfb45a2c6c4af8a55430770872517d8aceb702c321"} 09:52:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:52:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:52:28 INFO - Contents: 09:52:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5d7c70a2e9a9059b855a563cbe598aa5053a1e19cc51abf36d0f30fcdd3b4d3e28035a18fa4d85e71149d14cf9880b17919a0e225c7f815288bd644d989dd6c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a3091f30af4d3e8d94525cc7a4892af19e392e1dce46ad6c47a072ee12249692edc66a05aa6b6bbd97dff6dfb45a2c6c4af8a55430770872517d8aceb702c321"} 09:52:28 INFO - Running post-run listener: copy_logs_to_upload_dir 09:52:28 INFO - Copying logs to upload dir... 09:52:28 INFO - mkdir: /builds/slave/test/build/upload/logs 09:52:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.391202 ========= master_lag: 2.31 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-04-07 09:52:30.581789) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 10 secs) (at 2016-04-07 09:52:30.586127) ========= 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.bW9twSRqGl/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.RM2HGxHAiA/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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/a5d7c70a2e9a9059b855a563cbe598aa5053a1e19cc51abf36d0f30fcdd3b4d3e28035a18fa4d85e71149d14cf9880b17919a0e225c7f815288bd644d989dd6c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a3091f30af4d3e8d94525cc7a4892af19e392e1dce46ad6c47a072ee12249692edc66a05aa6b6bbd97dff6dfb45a2c6c4af8a55430770872517d8aceb702c321"} 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.011349 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/a5d7c70a2e9a9059b855a563cbe598aa5053a1e19cc51abf36d0f30fcdd3b4d3e28035a18fa4d85e71149d14cf9880b17919a0e225c7f815288bd644d989dd6c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a3091f30af4d3e8d94525cc7a4892af19e392e1dce46ad6c47a072ee12249692edc66a05aa6b6bbd97dff6dfb45a2c6c4af8a55430770872517d8aceb702c321"}' ========= master_lag: 10.73 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 10 secs) (at 2016-04-07 09:52:41.332333) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 09:52:41.332650) ========= 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.bW9twSRqGl/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.RM2HGxHAiA/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.005428 ========= master_lag: 0.84 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 09:52:42.173301) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 09:52:42.173614) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 09:52:43.110183) ========= ========= Total master_lag: 79.93 =========