builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0042 starttime: 1460045826.75 results: success (0) buildid: 20160407090707 builduid: 6c913fb39fb548f48c3896e080842fdc revision: 55f0de142be46043246b18108299aebf2bd95a64 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 09:17:06.752317) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 09:17:06.752725) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 09:17:06.753021) ========= 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.VBaQavBzz6/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.bFC4Utfd8L/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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.005745 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 09:17:06.775274) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 09:17:06.775582) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 09:17:06.790952) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 09:17:06.791266) ========= 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.VBaQavBzz6/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.bFC4Utfd8L/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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.005422 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 09:17:06.839973) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 09:17:06.840270) ========= 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:17:06.840628) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 09:17:06.840913) ========= 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.VBaQavBzz6/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.bFC4Utfd8L/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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:17:06-- 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% 73.3M=0s 2016-04-07 09:17:07 (73.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.185523 ========= master_lag: 0.29 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 09:17:07.311495) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 09:17:07.311830) ========= 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.VBaQavBzz6/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.bFC4Utfd8L/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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.020316 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 09:17:07.347283) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-07 09:17:07.347633) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 55f0de142be46043246b18108299aebf2bd95a64 --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 55f0de142be46043246b18108299aebf2bd95a64 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VBaQavBzz6/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.bFC4Utfd8L/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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:17:07,424 truncating revision to first 12 chars 2016-04-07 09:17:07,424 Setting DEBUG logging. 2016-04-07 09:17:07,424 attempt 1/10 2016-04-07 09:17:07,424 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/55f0de142be4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-07 09:17:08,459 unpacking tar archive at: fx-team-55f0de142be4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.288968 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-07 09:17:08.659213) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 09:17:08.659869) ========= echo 55f0de142be46043246b18108299aebf2bd95a64 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'55f0de142be46043246b18108299aebf2bd95a64'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VBaQavBzz6/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.bFC4Utfd8L/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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 55f0de142be46043246b18108299aebf2bd95a64 program finished with exit code 0 elapsedTime=0.004915 script_repo_revision: '55f0de142be46043246b18108299aebf2bd95a64' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 09:17:08.714778) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 09:17:08.715135) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 09:17:08.740309) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-07 09:17:08.741029) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.VBaQavBzz6/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.bFC4Utfd8L/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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:17:08 INFO - MultiFileLogger online at 20160407 09:17:08 in /builds/slave/test 09:17:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:17:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:17:08 INFO - {'append_to_log': False, 09:17:08 INFO - 'base_work_dir': '/builds/slave/test', 09:17:08 INFO - 'blob_upload_branch': 'Fx-Team', 09:17:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:17:08 INFO - 'branch': 'Fx-Team', 09:17:08 INFO - 'buildbot_json_path': 'buildprops.json', 09:17:08 INFO - 'config_files': ('talos/mac_config.py',), 09:17:08 INFO - 'default_actions': ('clobber', 09:17:08 INFO - 'read-buildbot-config', 09:17:08 INFO - 'download-and-extract', 09:17:08 INFO - 'populate-webroot', 09:17:08 INFO - 'create-virtualenv', 09:17:08 INFO - 'install', 09:17:08 INFO - 'run-tests'), 09:17:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:17:08 INFO - 'download_minidump_stackwalk': True, 09:17:08 INFO - 'download_symbols': 'ondemand', 09:17:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:17:08 INFO - 'tooltool.py': '/tools/tooltool.py', 09:17:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:17:08 INFO - '/tools/misc-python/virtualenv.py')}, 09:17:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:17:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:17:08 INFO - 'installer_path': 'installer.exe', 09:17:08 INFO - 'log_level': 'info', 09:17:08 INFO - 'log_name': 'talos', 09:17:08 INFO - 'log_to_console': True, 09:17:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:17:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:17:08 INFO - 'opt_config_files': (), 09:17:08 INFO - 'pip_index': False, 09:17:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:17:08 INFO - 'cmd': ('bash', 09:17:08 INFO - '-c', 09:17:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:17:08 INFO - 'enabled': True, 09:17:08 INFO - 'halt_on_failure': False, 09:17:08 INFO - 'name': 'check_screen_resolution'},), 09:17:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:17:08 INFO - 'cmd': ('bash', 09:17:08 INFO - '-c', 09:17:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:17:08 INFO - 'enabled': True, 09:17:08 INFO - 'halt_on_failure': False, 09:17:08 INFO - 'name': 'check_screen_resolution'},), 09:17:08 INFO - 'run_cmd_checks_enabled': True, 09:17:08 INFO - 'sps_profile': False, 09:17:08 INFO - 'sps_profile_interval': 0, 09:17:08 INFO - 'suite': 'dromaeojs', 09:17:08 INFO - 'system_bits': '32', 09:17:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:17:08 INFO - 'title': 't-yosemite-r7-0042', 09:17:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:17:08 INFO - 'use_talos_json': True, 09:17:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:17:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:17:08 INFO - 'work_dir': 'build'} 09:17:08 INFO - ##### 09:17:08 INFO - ##### Running clobber step. 09:17:08 INFO - ##### 09:17:08 INFO - Running pre-action listener: _resource_record_pre_action 09:17:08 INFO - Running main action method: clobber 09:17:08 INFO - rmtree: /builds/slave/test/build 09:17:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:17:09 INFO - Running post-action listener: _resource_record_post_action 09:17:09 INFO - ##### 09:17:09 INFO - ##### Running read-buildbot-config step. 09:17:09 INFO - ##### 09:17:09 INFO - Running pre-action listener: _resource_record_pre_action 09:17:09 INFO - Running main action method: read_buildbot_config 09:17:09 INFO - Using buildbot properties: 09:17:09 INFO - { 09:17:09 INFO - "project": "", 09:17:09 INFO - "product": "firefox", 09:17:09 INFO - "script_repo_revision": "production", 09:17:09 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 09:17:09 INFO - "repository": "", 09:17:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 09:17:09 INFO - "buildid": "20160407090707", 09:17:09 INFO - "stage_platform": "macosx64", 09:17:09 INFO - "basedir": "/builds/slave/test", 09:17:09 INFO - "buildnumber": 582, 09:17:09 INFO - "platform": "yosemite_r7", 09:17:09 INFO - "mozci_request": { 09:17:09 INFO - "priority": -1, 09:17:09 INFO - "type": "trigger_all_talos_jobs", 09:17:09 INFO - "times": 6 09:17:09 INFO - }, 09:17:09 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:17:09 INFO - "slavebuilddir": "test", 09:17:09 INFO - "branch": "fx-team", 09:17:09 INFO - "revision": "55f0de142be46043246b18108299aebf2bd95a64", 09:17:09 INFO - "slavename": "t-yosemite-r7-0042", 09:17:09 INFO - "builduid": "6c913fb39fb548f48c3896e080842fdc", 09:17:09 INFO - "repo_path": "integration/fx-team" 09:17:09 INFO - } 09:17:09 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459967170/firefox-48.0a1.en-US.mac.dmg. 09:17:09 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459967170/firefox-48.0a1.en-US.mac.test_packages.json. 09:17:09 INFO - Running post-action listener: _resource_record_post_action 09:17:09 INFO - ##### 09:17:09 INFO - ##### Running download-and-extract step. 09:17:09 INFO - ##### 09:17:09 INFO - Running pre-action listener: _resource_record_pre_action 09:17:09 INFO - Running main action method: download_and_extract 09:17:09 INFO - mkdir: /builds/slave/test/build/tests 09:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:09 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459967170/firefox-48.0a1.en-US.mac.test_packages.json 09:17:09 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459967170/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 09:17:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459967170/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:17:10 INFO - Downloaded 1199 bytes. 09:17:10 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 09:17:10 INFO - Using the following test package requirements: 09:17:10 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:17:10 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:17:10 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 09:17:10 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:17:10 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 09:17:10 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:17:10 INFO - u'jsshell-mac.zip'], 09:17:10 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:17:10 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 09:17:10 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:17:10 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:17:10 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 09:17:10 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:17:10 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 09:17:10 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:17:10 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 09:17:10 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:17:10 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 09:17:10 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:10 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459967170/firefox-48.0a1.en-US.mac.common.tests.zip 09:17:10 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459967170/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:17:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459967170/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:17:12 INFO - Downloaded 17970719 bytes. 09:17:12 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:17:12 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:17:15 INFO - Return code: 0 09:17:15 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:17: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:17:15 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459967170/firefox-48.0a1.en-US.mac.common.tests.zip 09:17:15 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459967170/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:17:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459967170/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:17:15 INFO - Downloaded 17970719 bytes. 09:17:15 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:17:15 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:17:19 INFO - Return code: 0 09:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:19 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459967170/firefox-48.0a1.en-US.mac.talos.tests.zip 09:17:19 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459967170/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:17:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459967170/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:17:19 INFO - Downloaded 10847617 bytes. 09:17:19 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:17:19 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:17:19 INFO - Return code: 0 09:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:19 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459967170/firefox-48.0a1.en-US.mac.dmg 09:17:19 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459967170/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 09:17:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459967170/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 09:17:20 INFO - Downloaded 108918781 bytes. 09:17:20 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459967170/firefox-48.0a1.en-US.mac.dmg 09:17:20 INFO - mkdir: /builds/slave/test/properties 09:17:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:17:20 INFO - Writing to file /builds/slave/test/properties/build_url 09:17:20 INFO - Contents: 09:17:20 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459967170/firefox-48.0a1.en-US.mac.dmg 09:17:20 INFO - Running post-action listener: _resource_record_post_action 09:17:20 INFO - Running post-action listener: set_extra_try_arguments 09:17:20 INFO - ##### 09:17:20 INFO - ##### Running populate-webroot step. 09:17:20 INFO - ##### 09:17:20 INFO - Running pre-action listener: _resource_record_pre_action 09:17:20 INFO - Running main action method: populate_webroot 09:17:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:17:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:17:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:17:20 INFO - '--tppagecycles', 09:17:20 INFO - '7'], 09:17:20 INFO - 'tests': ['tsvgm']}}, 09:17:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:17:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:17:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:17:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:17:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:17:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:17:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:20 INFO - 'talos_options': ['--disable-e10s'], 09:17:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:17:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:17:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:20 INFO - 'talos_options': ['--disable-e10s'], 09:17:20 INFO - 'tests': ['damp', 'tps']}, 09:17:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:20 INFO - 'tests': ['damp', 'tps']}, 09:17:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:17:20 INFO - 'tests': ['dromaeo_dom']}, 09:17:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:17:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:17:20 INFO - 'tests': ['a11yr', 09:17:20 INFO - 'ts_paint', 09:17:20 INFO - 'tpaint', 09:17:20 INFO - 'sessionrestore', 09:17:20 INFO - 'sessionrestore_no_auto_restore', 09:17:20 INFO - 'tabpaint']}, 09:17:20 INFO - 'other-e10s': {'tests': ['a11yr', 09:17:20 INFO - 'ts_paint', 09:17:20 INFO - 'tpaint', 09:17:20 INFO - 'sessionrestore', 09:17:20 INFO - 'sessionrestore_no_auto_restore', 09:17:20 INFO - 'tabpaint']}, 09:17:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:17:20 INFO - 'ts_paint', 09:17:20 INFO - 'tpaint', 09:17:20 INFO - 'sessionrestore', 09:17:20 INFO - 'sessionrestore_no_auto_restore', 09:17:20 INFO - 'tabpaint']}, 09:17:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:17:20 INFO - 'ts_paint', 09:17:20 INFO - 'tpaint', 09:17:20 INFO - 'sessionrestore', 09:17:20 INFO - 'sessionrestore_no_auto_restore', 09:17:20 INFO - 'tabpaint']}, 09:17:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:17:20 INFO - 'tests': ['a11yr', 09:17:20 INFO - 'ts_paint', 09:17:20 INFO - 'tpaint', 09:17:20 INFO - 'sessionrestore', 09:17:20 INFO - 'sessionrestore_no_auto_restore', 09:17:20 INFO - 'tabpaint']}, 09:17:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:17:20 INFO - 'tests': ['a11yr', 09:17:20 INFO - 'ts_paint', 09:17:20 INFO - 'tpaint', 09:17:20 INFO - 'sessionrestore', 09:17:20 INFO - 'sessionrestore_no_auto_restore', 09:17:20 INFO - 'tabpaint']}, 09:17:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:17:20 INFO - 'tests': ['tsvgx', 09:17:20 INFO - 'tsvgr_opacity', 09:17:20 INFO - 'tart', 09:17:20 INFO - 'tscrollx', 09:17:20 INFO - 'cart']}, 09:17:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:17:20 INFO - 'tsvgr_opacity', 09:17:20 INFO - 'tart', 09:17:20 INFO - 'tscrollx', 09:17:20 INFO - 'cart']}, 09:17:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:20 INFO - 'talos_options': ['--disable-e10s'], 09:17:20 INFO - 'tests': ['tp5o']}, 09:17:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:20 INFO - 'tests': ['tp5o']}, 09:17:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:20 INFO - 'talos_options': ['--disable-e10s', 09:17:20 INFO - '--xperf_path', 09:17:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:17:20 INFO - 'tests': ['tp5n']}, 09:17:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:20 INFO - 'talos_options': ['--xperf_path', 09:17:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:17:20 INFO - 'tests': ['tp5n']}}, 09:17:20 INFO - 'talos.zip': {'path': '', 09:17:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:17:20 INFO - Running post-action listener: _resource_record_post_action 09:17:20 INFO - ##### 09:17:20 INFO - ##### Running create-virtualenv step. 09:17:20 INFO - ##### 09:17:20 INFO - Running pre-action listener: _resource_record_pre_action 09:17:20 INFO - Running main action method: create_virtualenv 09:17:20 INFO - Creating virtualenv /builds/slave/test/build/venv 09:17:20 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:17:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:17:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:17:21 INFO - Using real prefix '/tools/python27' 09:17:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:17:21 INFO - Installing distribute.............................................................................................................................................................................................done. 09:17:24 INFO - Installing pip.................done. 09:17:24 INFO - Return code: 0 09:17:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:17:24 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:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:24 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:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:24 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 0x105763a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105773420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda68dba6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105602e00>, '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 0x10542bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055fdb20>, '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.VBaQavBzz6/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.bFC4Utfd8L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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:17:24 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:17:24 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:17:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VBaQavBzz6/Render', 09:17:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:24 INFO - 'HOME': '/Users/cltbld', 09:17:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:24 INFO - 'LOGNAME': 'cltbld', 09:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:24 INFO - 'MOZ_NO_REMOTE': '1', 09:17:24 INFO - 'NO_EM_RESTART': '1', 09:17:24 INFO - 'PAGER': '/bin/cat', 09:17:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:24 INFO - 'PWD': '/builds/slave/test', 09:17:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:24 INFO - 'SHELL': '/bin/bash', 09:17:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bFC4Utfd8L/Listeners', 09:17:24 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 09:17:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:24 INFO - 'USER': 'cltbld', 09:17:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:24 INFO - 'XPC_FLAGS': '0x0', 09:17:24 INFO - 'XPC_SERVICE_NAME': '0', 09:17:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:24 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:17:24 INFO - Cleaning up... 09:17:24 INFO - Return code: 0 09:17:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:17:24 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:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:24 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:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:24 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 0x105763a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105773420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda68dba6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105602e00>, '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 0x10542bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055fdb20>, '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.VBaQavBzz6/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.bFC4Utfd8L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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:17:24 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:17:24 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:17:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VBaQavBzz6/Render', 09:17:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:24 INFO - 'HOME': '/Users/cltbld', 09:17:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:24 INFO - 'LOGNAME': 'cltbld', 09:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:24 INFO - 'MOZ_NO_REMOTE': '1', 09:17:24 INFO - 'NO_EM_RESTART': '1', 09:17:24 INFO - 'PAGER': '/bin/cat', 09:17:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:24 INFO - 'PWD': '/builds/slave/test', 09:17:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:24 INFO - 'SHELL': '/bin/bash', 09:17:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bFC4Utfd8L/Listeners', 09:17:24 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 09:17:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:24 INFO - 'USER': 'cltbld', 09:17:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:24 INFO - 'XPC_FLAGS': '0x0', 09:17:24 INFO - 'XPC_SERVICE_NAME': '0', 09:17:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:25 INFO - Downloading/unpacking psutil>=0.7.1 09:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:17:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:17:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:17:28 INFO - Installing collected packages: psutil 09:17:28 INFO - Running setup.py install for psutil 09:17:28 INFO - building 'psutil._psutil_osx' extension 09:17:28 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:17:28 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:17:28 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:17:28 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:17:28 INFO - building 'psutil._psutil_posix' extension 09:17:28 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:17:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:17:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:17:28 INFO - ^ 09:17:28 INFO - 1 warning generated. 09:17:28 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:17:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:17:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:17:28 INFO - Successfully installed psutil 09:17:28 INFO - Cleaning up... 09:17:28 INFO - Return code: 0 09:17:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:17:28 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:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:28 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:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:28 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 0x105763a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105773420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda68dba6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105602e00>, '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 0x10542bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055fdb20>, '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.VBaQavBzz6/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.bFC4Utfd8L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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:17:28 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:17:28 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:17:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VBaQavBzz6/Render', 09:17:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:28 INFO - 'HOME': '/Users/cltbld', 09:17:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:28 INFO - 'LOGNAME': 'cltbld', 09:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:28 INFO - 'MOZ_NO_REMOTE': '1', 09:17:28 INFO - 'NO_EM_RESTART': '1', 09:17:28 INFO - 'PAGER': '/bin/cat', 09:17:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:28 INFO - 'PWD': '/builds/slave/test', 09:17:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:28 INFO - 'SHELL': '/bin/bash', 09:17:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bFC4Utfd8L/Listeners', 09:17:28 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 09:17:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:28 INFO - 'USER': 'cltbld', 09:17:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:28 INFO - 'XPC_FLAGS': '0x0', 09:17:28 INFO - 'XPC_SERVICE_NAME': '0', 09:17:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:17:29 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:17:29 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:17:29 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:17:29 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:17:29 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:17:29 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:17:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:17:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:17:31 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:17:31 INFO - Installing collected packages: mozsystemmonitor 09:17:31 INFO - Running setup.py install for mozsystemmonitor 09:17:31 INFO - Successfully installed mozsystemmonitor 09:17:31 INFO - Cleaning up... 09:17:31 INFO - Return code: 0 09:17:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:17:31 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:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:31 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:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:31 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 0x105763a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105773420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda68dba6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105602e00>, '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 0x10542bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055fdb20>, '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.VBaQavBzz6/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.bFC4Utfd8L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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:17:31 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:17:31 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:17:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VBaQavBzz6/Render', 09:17:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:31 INFO - 'HOME': '/Users/cltbld', 09:17:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:31 INFO - 'LOGNAME': 'cltbld', 09:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:31 INFO - 'MOZ_NO_REMOTE': '1', 09:17:31 INFO - 'NO_EM_RESTART': '1', 09:17:31 INFO - 'PAGER': '/bin/cat', 09:17:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:31 INFO - 'PWD': '/builds/slave/test', 09:17:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:31 INFO - 'SHELL': '/bin/bash', 09:17:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bFC4Utfd8L/Listeners', 09:17:31 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 09:17:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:31 INFO - 'USER': 'cltbld', 09:17:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:31 INFO - 'XPC_FLAGS': '0x0', 09:17:31 INFO - 'XPC_SERVICE_NAME': '0', 09:17:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:32 INFO - Downloading/unpacking blobuploader==1.2.4 09:17:32 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:17:32 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:17:32 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:17:32 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:17:32 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:17:32 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:17:34 INFO - Downloading blobuploader-1.2.4.tar.gz 09:17:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:17:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:17:34 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:17:34 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:17:34 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:17:34 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:17:34 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:17:34 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:17:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:17:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:17:35 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:17:35 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:17:35 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:17:35 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:17:35 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:17:35 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:17:35 INFO - Downloading docopt-0.6.1.tar.gz 09:17:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:17:35 INFO - Installing collected packages: blobuploader, requests, docopt 09:17:35 INFO - Running setup.py install for blobuploader 09:17:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:17:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:17:35 INFO - Running setup.py install for requests 09:17:36 INFO - Running setup.py install for docopt 09:17:36 INFO - Successfully installed blobuploader requests docopt 09:17:36 INFO - Cleaning up... 09:17:36 INFO - Return code: 0 09:17:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:17:36 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:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:37 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:17:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:37 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 0x105763a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105773420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda68dba6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105602e00>, '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 0x10542bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055fdb20>, '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.VBaQavBzz6/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.bFC4Utfd8L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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:17:37 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:17:37 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:17:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VBaQavBzz6/Render', 09:17:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:37 INFO - 'HOME': '/Users/cltbld', 09:17:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:37 INFO - 'LOGNAME': 'cltbld', 09:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:37 INFO - 'MOZ_NO_REMOTE': '1', 09:17:37 INFO - 'NO_EM_RESTART': '1', 09:17:37 INFO - 'PAGER': '/bin/cat', 09:17:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:37 INFO - 'PWD': '/builds/slave/test', 09:17:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:37 INFO - 'SHELL': '/bin/bash', 09:17:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bFC4Utfd8L/Listeners', 09:17:37 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 09:17:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:37 INFO - 'USER': 'cltbld', 09:17:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:37 INFO - 'XPC_FLAGS': '0x0', 09:17:37 INFO - 'XPC_SERVICE_NAME': '0', 09:17:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:17:37 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-7PgLJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:17:37 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-Y20SUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:17:37 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-_pmkeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:17:37 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-TQJbCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:17:37 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-tFhTjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:17:37 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-XhiKYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:17:38 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-oTCRly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:17:38 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-kTz30U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:17:38 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-_wBeIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:17:38 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-KsPKXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:17:38 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-7AC5v2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:17:38 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-TOJLCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:17:38 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-N1PytG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:17:38 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-ILFznQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:17:38 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-Tzf0bn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:17:39 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-kXkPJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:17:39 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-eoeWcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:17:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:17:39 INFO - Running setup.py install for manifestparser 09:17:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:17:39 INFO - Running setup.py install for mozcrash 09:17:39 INFO - Running setup.py install for mozdebug 09:17:39 INFO - Running setup.py install for mozdevice 09:17:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:17:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:17:39 INFO - Running setup.py install for mozfile 09:17:39 INFO - Running setup.py install for mozhttpd 09:17:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:17:40 INFO - Running setup.py install for mozinfo 09:17:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:17:40 INFO - Running setup.py install for mozInstall 09:17:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:17:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:17:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:17:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:17:40 INFO - Running setup.py install for mozleak 09:17:40 INFO - Running setup.py install for mozlog 09:17:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:17:40 INFO - Running setup.py install for moznetwork 09:17:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:17:40 INFO - Running setup.py install for mozprocess 09:17:41 INFO - Running setup.py install for mozprofile 09:17:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:17:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:17:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:17:41 INFO - Running setup.py install for mozrunner 09:17:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:17:41 INFO - Running setup.py install for mozscreenshot 09:17:41 INFO - Running setup.py install for moztest 09:17:41 INFO - Running setup.py install for mozversion 09:17:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:17:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:17:41 INFO - Cleaning up... 09:17:41 INFO - Return code: 0 09:17:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:17:41 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:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:41 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:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:41 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 0x105763a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105773420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda68dba6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105602e00>, '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 0x10542bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055fdb20>, '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.VBaQavBzz6/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.bFC4Utfd8L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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:17:41 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:17:41 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:17:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VBaQavBzz6/Render', 09:17:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:41 INFO - 'HOME': '/Users/cltbld', 09:17:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:41 INFO - 'LOGNAME': 'cltbld', 09:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:41 INFO - 'MOZ_NO_REMOTE': '1', 09:17:41 INFO - 'NO_EM_RESTART': '1', 09:17:41 INFO - 'PAGER': '/bin/cat', 09:17:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:41 INFO - 'PWD': '/builds/slave/test', 09:17:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:41 INFO - 'SHELL': '/bin/bash', 09:17:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bFC4Utfd8L/Listeners', 09:17:41 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 09:17:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:41 INFO - 'USER': 'cltbld', 09:17:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:41 INFO - 'XPC_FLAGS': '0x0', 09:17:41 INFO - 'XPC_SERVICE_NAME': '0', 09:17:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:17:42 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-DJjh6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:17:42 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:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:17:42 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-e_KYgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:17:42 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:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:17:42 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-3_SuKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:17:42 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:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:17:42 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-fpNDpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:17:42 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:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:17:42 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-6h0yH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:17:42 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:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:17:42 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-XCPxCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:17:42 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:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:17:42 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-rRZmp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:17:42 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:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:17:42 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-PHzcMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:17:42 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:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:17:42 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-_prM5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:17:43 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:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:17:43 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-wjCCLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:17:43 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:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:17:43 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-7kIKgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:17:43 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:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:17:43 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-7lJnQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:17:43 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:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:17:43 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-CrPqyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:17:43 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:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:17:43 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-wpgyDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:17:43 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:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:17:43 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-Xi0Ze0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:17:43 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:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:17:43 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-dOzSdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:17:43 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:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:17:43 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-OM6lOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:17:43 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:17:43 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:17:43 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:17:43 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:17:43 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:17:43 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:17:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:46 INFO - Downloading blessings-1.6.tar.gz 09:17:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:17:46 INFO - Installing collected packages: blessings 09:17:46 INFO - Running setup.py install for blessings 09:17:46 INFO - Successfully installed blessings 09:17:46 INFO - Cleaning up... 09:17:47 INFO - Return code: 0 09:17:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:17:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:17:47 INFO - Reading from file tmpfile_stdout 09:17:47 INFO - Current package versions: 09:17:47 INFO - blessings == 1.6 09:17:47 INFO - blobuploader == 1.2.4 09:17:47 INFO - docopt == 0.6.1 09:17:47 INFO - manifestparser == 1.1 09:17:47 INFO - mozInstall == 1.12 09:17:47 INFO - mozcrash == 0.17 09:17:47 INFO - mozdebug == 0.1 09:17:47 INFO - mozdevice == 0.48 09:17:47 INFO - mozfile == 1.2 09:17:47 INFO - mozhttpd == 0.7 09:17:47 INFO - mozinfo == 0.9 09:17:47 INFO - mozleak == 0.1 09:17:47 INFO - mozlog == 3.1 09:17:47 INFO - moznetwork == 0.27 09:17:47 INFO - mozprocess == 0.22 09:17:47 INFO - mozprofile == 0.28 09:17:47 INFO - mozrunner == 6.11 09:17:47 INFO - mozscreenshot == 0.1 09:17:47 INFO - mozsystemmonitor == 0.0 09:17:47 INFO - moztest == 0.7 09:17:47 INFO - mozversion == 1.4 09:17:47 INFO - psutil == 3.1.1 09:17:47 INFO - requests == 1.2.3 09:17:47 INFO - wsgiref == 0.1.2 09:17:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:47 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 0x105763a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105773420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda68dba6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105602e00>, '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 0x10542bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055fdb20>, '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.VBaQavBzz6/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.bFC4Utfd8L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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:17:47 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:17:47 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:17:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VBaQavBzz6/Render', 09:17:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:47 INFO - 'HOME': '/Users/cltbld', 09:17:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:47 INFO - 'LOGNAME': 'cltbld', 09:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:47 INFO - 'MOZ_NO_REMOTE': '1', 09:17:47 INFO - 'NO_EM_RESTART': '1', 09:17:47 INFO - 'PAGER': '/bin/cat', 09:17:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:47 INFO - 'PWD': '/builds/slave/test', 09:17:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:47 INFO - 'SHELL': '/bin/bash', 09:17:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bFC4Utfd8L/Listeners', 09:17:47 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 09:17:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:47 INFO - 'USER': 'cltbld', 09:17:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:47 INFO - 'XPC_FLAGS': '0x0', 09:17:47 INFO - 'XPC_SERVICE_NAME': '0', 09:17:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:47 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:17:47 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:17:47 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:17:47 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:17:47 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:17:47 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:17:47 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:17:47 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:17:47 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:17:47 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:17:47 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:17:47 INFO - Cleaning up... 09:17:47 INFO - Return code: 0 09:17:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:47 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 0x105763a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105773420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda68dba6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105602e00>, '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 0x10542bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055fdb20>, '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.VBaQavBzz6/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.bFC4Utfd8L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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:17:47 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:17:47 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:17:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VBaQavBzz6/Render', 09:17:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:47 INFO - 'HOME': '/Users/cltbld', 09:17:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:47 INFO - 'LOGNAME': 'cltbld', 09:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:47 INFO - 'MOZ_NO_REMOTE': '1', 09:17:47 INFO - 'NO_EM_RESTART': '1', 09:17:47 INFO - 'PAGER': '/bin/cat', 09:17:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:47 INFO - 'PWD': '/builds/slave/test', 09:17:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:47 INFO - 'SHELL': '/bin/bash', 09:17:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bFC4Utfd8L/Listeners', 09:17:47 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 09:17:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:47 INFO - 'USER': 'cltbld', 09:17:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:47 INFO - 'XPC_FLAGS': '0x0', 09:17:47 INFO - 'XPC_SERVICE_NAME': '0', 09:17:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:47 INFO - Downloading/unpacking jsonschema 09:17:47 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:17:47 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:17:47 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:17:47 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:17:47 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:17:47 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:17:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:17:50 INFO - Downloading/unpacking functools32 (from jsonschema) 09:17:50 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:17:50 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:17:50 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:17:50 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:17:50 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:17:50 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:17:50 INFO - Downloading functools32-3.2.3-2.tar.gz 09:17:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:17:50 INFO - warning: no files found matching '*.txt' 09:17:50 INFO - no previously-included directories found matching 'build' 09:17:50 INFO - no previously-included directories found matching 'dist' 09:17:50 INFO - no previously-included directories found matching '.git*' 09:17:50 INFO - Installing collected packages: jsonschema, functools32 09:17:50 INFO - Running setup.py install for functools32 09:17:50 INFO - warning: no files found matching '*.txt' 09:17:50 INFO - no previously-included directories found matching 'build' 09:17:50 INFO - no previously-included directories found matching 'dist' 09:17:50 INFO - no previously-included directories found matching '.git*' 09:17:51 INFO - Successfully installed jsonschema functools32 09:17:51 INFO - Cleaning up... 09:17:51 INFO - Return code: 0 09:17:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:51 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 0x105763a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105773420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda68dba6a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105602e00>, '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 0x10542bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055fdb20>, '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.VBaQavBzz6/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.bFC4Utfd8L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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:17:51 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:17:51 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:17:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VBaQavBzz6/Render', 09:17:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:51 INFO - 'HOME': '/Users/cltbld', 09:17:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:51 INFO - 'LOGNAME': 'cltbld', 09:17:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:51 INFO - 'MOZ_NO_REMOTE': '1', 09:17:51 INFO - 'NO_EM_RESTART': '1', 09:17:51 INFO - 'PAGER': '/bin/cat', 09:17:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:51 INFO - 'PWD': '/builds/slave/test', 09:17:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:51 INFO - 'SHELL': '/bin/bash', 09:17:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bFC4Utfd8L/Listeners', 09:17:51 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 09:17:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:51 INFO - 'USER': 'cltbld', 09:17:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:51 INFO - 'XPC_FLAGS': '0x0', 09:17:51 INFO - 'XPC_SERVICE_NAME': '0', 09:17:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:51 INFO - Downloading/unpacking flake8 09:17:51 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:17:51 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:17:51 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:17:51 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:17:51 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:17:51 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:17:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:17:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:17:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:17: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:17: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:17: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:17: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:17: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:17: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:17:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:17: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:17: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:17: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:17: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:17: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:17: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:17:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:17:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:17:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:17:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:17:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:17:55 INFO - no previously-included directories found matching 'docs/_build' 09:17:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:17:55 INFO - Running setup.py install for pep8 09:17:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:17:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:17:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:17:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:17:55 INFO - no previously-included directories found matching 'docs/_build' 09:17:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:17:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:17:55 INFO - Cleaning up... 09:17:55 INFO - Return code: 0 09:17:55 INFO - Running post-action listener: _resource_record_post_action 09:17:55 INFO - Running post-action listener: _start_resource_monitoring 09:17:55 INFO - Starting resource monitoring. 09:17:55 INFO - ##### 09:17:55 INFO - ##### Running install step. 09:17:55 INFO - ##### 09:17:55 INFO - Running pre-action listener: _resource_record_pre_action 09:17:55 INFO - Running main action method: install 09:17:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:17:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:17:55 INFO - Reading from file tmpfile_stdout 09:17:55 INFO - Detecting whether we're running mozinstall >=1.0... 09:17:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:17:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:17:55 INFO - Reading from file tmpfile_stdout 09:17:55 INFO - Output received: 09:17:55 INFO - Usage: mozinstall [options] installer 09:17:55 INFO - Options: 09:17:55 INFO - -h, --help show this help message and exit 09:17:55 INFO - -d DEST, --destination=DEST 09:17:55 INFO - Directory to install application into. [default: 09:17:55 INFO - "/builds/slave/test"] 09:17:55 INFO - --app=APP Application being installed. [default: firefox] 09:17:55 INFO - mkdir: /builds/slave/test/build/application 09:17:55 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:17:55 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:18:29 INFO - Reading from file tmpfile_stdout 09:18:29 INFO - Output received: 09:18:29 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:18:29 INFO - Running post-action listener: _resource_record_post_action 09:18:29 INFO - ##### 09:18:29 INFO - ##### Running run-tests step. 09:18:29 INFO - ##### 09:18:29 INFO - Running pre-action listener: _resource_record_pre_action 09:18:29 INFO - Running main action method: run_tests 09:18:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:18:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:18:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:18:29 INFO - 2016-04-07 09:18:29.719 screenresolution[1979:13011] starting screenresolution argv=screenresolution get 09:18:29 INFO - 2016-04-07 09:18:29.721 screenresolution[1979:13011] Display 0: 1600x1200x32@60 09:18:29 INFO - 2016-04-07 09:18:29.727 screenresolution[1980:13013] starting screenresolution argv=screenresolution list 09:18:29 INFO - Available Modes on Display 0 09:18:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:18:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:18:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:18:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:18:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:18:29 INFO - Intel Iris: 09:18:29 INFO - Chipset Model: Intel Iris 09:18:29 INFO - Type: GPU 09:18:29 INFO - Bus: Built-In 09:18:29 INFO - VRAM (Dynamic, Max): 1536 MB 09:18:29 INFO - Vendor: Intel (0x8086) 09:18:29 INFO - Device ID: 0x0a2e 09:18:29 INFO - Revision ID: 0x0009 09:18:29 INFO - Displays: 09:18:29 INFO - Display: 09:18:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:18:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:18:29 INFO - Display Serial Number: 1600x1200 60 09:18:29 INFO - Main Display: Yes 09:18:29 INFO - Mirror: Off 09:18:29 INFO - Online: Yes 09:18:29 INFO - Rotation: Supported 09:18:29 INFO - Return code: 0 09:18:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:18:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:18:29 INFO - Python 2.7.3 09:18:29 INFO - Return code: 0 09:18:29 INFO - grabbing minidump binary from tooltool 09:18:29 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:18:29 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 0x105602e00>, '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 0x10542bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055fdb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:18:29 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:18:29 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:18:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:18:30 INFO - Return code: 0 09:18:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:18:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:18:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:18:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:18:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:18:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:18:31 INFO - Return code: 0 09:18:31 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459967170/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:18:31 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459967170/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:18:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VBaQavBzz6/Render', 09:18:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:31 INFO - 'HOME': '/Users/cltbld', 09:18:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:31 INFO - 'LOGNAME': 'cltbld', 09:18:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:18:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:18:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:31 INFO - 'MOZ_NO_REMOTE': '1', 09:18:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:18:31 INFO - 'NO_EM_RESTART': '1', 09:18:31 INFO - 'PAGER': '/bin/cat', 09:18:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:31 INFO - 'PWD': '/builds/slave/test', 09:18:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:18:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:31 INFO - 'SHELL': '/bin/bash', 09:18:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bFC4Utfd8L/Listeners', 09:18:31 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 09:18:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:31 INFO - 'USER': 'cltbld', 09:18:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:31 INFO - 'XPC_FLAGS': '0x0', 09:18:31 INFO - 'XPC_SERVICE_NAME': '0', 09:18:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459967170/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:18:31 INFO - mozversion application_buildid: 20160406112610 09:18:31 INFO - mozversion application_changeset: 55f0de142be46043246b18108299aebf2bd95a64 09:18:31 INFO - mozversion application_display_name: Nightly 09:18:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:18:31 INFO - mozversion application_name: Firefox 09:18:31 INFO - mozversion application_remotingname: firefox 09:18:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:18:31 INFO - mozversion application_vendor: Mozilla 09:18:31 INFO - mozversion application_version: 48.0a1 09:18:31 INFO - mozversion platform_buildid: 20160406112610 09:18:31 INFO - mozversion platform_changeset: 55f0de142be46043246b18108299aebf2bd95a64 09:18:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:18:31 INFO - mozversion platform_version: 48.0a1 09:18:31 INFO - using testdate: 1460045911 09:18:31 INFO - actual date: 1460045911 09:18:31 INFO - starting webserver on 'localhost:49490' 09:18:31 INFO - SUITE-START | Running 2 tests 09:18:31 INFO - TEST-START | dromaeo_css 09:18:31 INFO - operating with platform_type : mac_ 09:18:31 INFO - Initialising browser for dromaeo_css test... 09:18:31 INFO - TEST-INFO | started process 1998 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/tmp8j4yj8/profile http://localhost:49490/getInfo.html) 09:18:33 INFO - PROCESS | 1998 | __metrics Screen width/height:1600/1200 09:18:33 INFO - PROCESS | 1998 | colorDepth:24 09:18:33 INFO - PROCESS | 1998 | Browser inner width/height: 1024/689 09:18:33 INFO - PROCESS | 1998 | __metrics 09:18:33 INFO - PROCESS | 1998 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:18:33 ERROR - PROCESS | 1998 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:18:34 INFO - TEST-INFO | 1998: exit 0 09:18:34 INFO - Browser initialized. 09:18:34 INFO - Running cycle 1/1 for dromaeo_css test... 09:18:34 INFO - TEST-INFO | started process 2000 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/tmp8j4yj8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:18:46 INFO - PROCESS | 2000 | RSS: Main: 237056000 09:18:46 INFO - PROCESS | 2000 | 09:19:37 INFO - PROCESS | 2000 | 1460045977958 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:21:49 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49490/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49490/tests/dromaeo/cssquery-ext.html) 09:21:50 INFO - PROCESS | 2000 | RSS: Main: 371126272 09:21:50 INFO - PROCESS | 2000 | 09:24:53 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49490/tests/dromaeo/cssquery-ext.html (next: http://localhost:49490/tests/dromaeo/cssquery-jquery.html) 09:24:53 INFO - PROCESS | 2000 | RSS: Main: 362536960 09:24:53 INFO - PROCESS | 2000 | 09:27:55 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49490/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49490/tests/dromaeo/cssquery-mootools.html) 09:27:56 INFO - PROCESS | 2000 | RSS: Main: 366239744 09:27:56 INFO - PROCESS | 2000 | 09:30:58 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49490/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49490/tests/dromaeo/cssquery-prototype.html) 09:30:59 INFO - PROCESS | 2000 | RSS: Main: 331247616 09:30:59 INFO - PROCESS | 2000 | 09:34:02 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49490/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49490/tests/dromaeo/cssquery-yui.html) 09:34:02 INFO - PROCESS | 2000 | RSS: Main: 332701696 09:34:02 INFO - PROCESS | 2000 | 09:37:05 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49490/tests/dromaeo/cssquery-yui.html (next: http://localhost:49490/tests/dromaeo/cssquery-dojo.html) 09:37:05 INFO - PROCESS | 2000 | RSS: Main: 410136576 09:37:05 INFO - PROCESS | 2000 | 09:37:05 INFO - PROCESS | 2000 | __start_tp_report 09:37:05 INFO - PROCESS | 2000 | _x_x_mozilla_page_load 09:37:05 INFO - PROCESS | 2000 | _x_x_mozilla_page_load_details 09:37:05 INFO - PROCESS | 2000 | |i|pagename|runs| 09:37:05 INFO - PROCESS | 2000 | |0;dojo.html;3413.4879768034793;3454.5681789776277;3486.3027394521087;3498.177928186877;3548.343556442057;5600.355959064709;5750.252467179261;5801.216835727176;5816.651000939942;5818.941810581893;5652.925944070624;5734.197212390269;5778.595498315109;5794.768209271635;5807.274090738658;4373.300271956487;4566.885827854297;4935.062338155757;5148.3821941366905;5167.509086636764;5232.29364035856;5242.711650859202;5244.134717771563;5258.44786297439;5267.52592266696;4715.552022557868;5176.5341119299255;5209.661372010826;5231.712255825928;5234.214867769827;4891.902161956758;5250.264962905158;5255;5259.5529380002745;5318.388385335658;5092.694438333675;5100.464451232641;5152.330197074394;5178.352705911761;5179.766910489037;5121.795128194868;5395.433479484676;5620.606557540974;5640.2667653205235;5643.294588176478;6114;6134.8159555213415;6140.4473597376;6149.077638354238;6163.19878415803;6124.3809352984035;6125.9892117800955;6192.566520343577;6204.503639708858;6216.160818289518;5939.346671866091;5973.820785376446;5991.7902873399225;6005.129256257818;6024.879502409927;6238.968805155945;6239.095331176954;6271.7804876830005;6276.215473065867;6280.403361680633;5934.910976335358;6122.846928826815;6131.040261761288;6147.262328520606;6164.6917654117115;6105.572609917263;6162.784302549389;6166.81499555014;6173.969130154321;6186.133941248228;6081.370449678783;6127.938720612737;6136.8772624547255;6156.969215153896;6170.444659980623;6100.1270446244;6127.571070025056;6167.722452489649;6188.783392581238;6192.566520343623;4929.186684197068;4942.604591632661;4942.654014219042;4947.406311242674;4958.9008219835405;4411.514733379326;4463.12968971054;4481.036577135931;4491.663125265618;4514.345419914094;5650;5711.942880571224;5723.570732195102;5741.25363702716;5771.451712087345;6168.599041062316;6171.6297022178815;6187.010078387437;6192.969035154795;6208.0998255253635;5538.667679939216;5632.04255276604;5637.210790489335;5701.2018317435595;5731.742071606787;5384.057789886754;5401.540869026098;5408.729563521808;5413.729313534308;5421.403645598981;5291.285676433709;6234.9688251558455;6238.719257633417;6247.125402443661;6282.434580887742;6180.938190618216;6192.256929168529;6192.628442293477;6197.101420294122;6204.317525072329;5812.244408226903;6306.243250809932;6314.305426403;6316;6322.873542529215;6108.4807791338235;6144;6151.200343955436;6195.845103872259;6228.626282423069;6119.715820550657;6179.84550386244;6207.6585787782105;6208.2239720034995;6218.098375735583;6098.664573448325;6142.938570614237;6144.262688477412;6184.659843708459;6189.597676151036;6009.909851352146;6095.512359011357;6132.264128304632;6139.938600613937;6144.569880108528;6012.188354572252;6037.758489660365;6040.456358927718;6047.606905551125;6098.054801505774;6136.355682653436;6148.077788331786;6149.108379285068;6156.476699480594;6177.166082578974;5911.704414779329;5926.407359264212;5949;5962.791302304398;6029.728662210124 09:37:05 INFO - PROCESS | 2000 | |1;ext.html;456.910902374037;531.4366771222502;569.632586981397;629.3077614623913;631.4601016131207;30268.24329391766;33063.33873322532;38615;38644.42033369498;39038.609613903885;42254.7887260564;42461;42651.7204483866;42771.78614106925;42812.78593607035;9361.391509551875;9584.37701549397;9603.855942160873;9608.183304419097;9614.086661767122;9438.622455101788;9592.616295348213;9598.136167744902;9612.9425763166;9711.028897110267;9604.951975240114;9701.175400091;9715;9718.125368716814;9731.610735570568;8440.577971101482;9616.80766384672;9706.61173553057;9717.659881904136;9742.707718768448;9423.952880235624;9440.716778496657;9504.4297342159;9573.04269573044;9586.281028922858;40948.59051409477;41150.1769964599;41202.38196427056;41223.587764122276;41230;3132.3891841090995;3183.442897492953;3215.565898603682;3218.5976752905885;3417.79493230407;23935.76064239353;27054.45891082187;27789;28626;28693;2667.9599806002925;2722.992492777665;2749.8212616180085;2817.2393453767572;2868.885244590214;502783;510712.9999999963;511386;512171.4391428019;513141.9999999963;68361;69635.65182174159;70293;70928.64535677392;70989;73266;73363.63318183481;73410.26589734034;73413.26586734172;73422.63288683523;17306.394276200273;17598.736018959728;17608.82391176072;17617.207225674876;17632;11805.350705711096;12188.207766495327;12212.267263964191;12247.877521224851;13025.544105956436;15827.402243349521;21971.670424943637;22246.221382251868;22276.888615556818;22303.996320165632;8705.390622656354;8838.55807209637;9279.582418791171;9488.667896623585;9571.138597526256;922.2852289475576;928.6935311347239;995.4922989275522;1123.741539445932;1171.8828117188214;29055.70944290572;29326.853365733463;29716.702832971827;29821.254468638024;30752.384952301276;1031.097789434245;1039.449091981251;1060.7295139739472;1070.4594179939081;1142.2461175624048;14543.418263269563;14648.85351146475;14729.337179826933;14931.477398291225;15032.924835375972;665873;666129.3387066164;676927;677619;678048;60441.69779151076;61175;61251.6937415319;61278.080828787606;61497.69251153805;1327.3694994877355;1436.0593811053777;1444.061360115933;1465.5896349022291;1467.2370367408887;28756.568651469825;28811.56782648304;29453.558196627495;29824.54388400082;30325;50236;50760.74619626878;50891;50898.49101508938;50925.745371272904;411179;425444;426541;426541;636018;32872;33378;33842.984710458724;34375;34393.96818095461;36798.63201367952;37183.256334873695;40956.33783804043;41770.58229417667;42287.36568951407;34859.47710784391;35022.29955400929;35098.82450587731;35679.28641427209;35812.82093589516;34356.312873742885;34563.654363456044;34893.127671808405;35093.94718158459;35134.64865351416;34740.957771266905;34770.304593908484;35168;35731.46402803908;36479.817600911825;30018.69981300159;30901.381972359977;30958.38083238368;30996.845015774776;31004.689953101082;23508.059677612702;23654.290371288887;24152.63771043471;24200.878995605613;24316 09:37:05 INFO - PROCESS | 2000 | |2;jquery.html;361.878770611845;361.9131408461969;362.15436954710765;372.0160176333596;373.342916467018;19586.020698965065;20153.395398138062;20340.288089916874;20877;20882.791172088273;19305.613887722273;20033.898135602536;20576.794232057677;20637.277695280667;20692.89653551734;5709.971450142754;5926.199963005004;5943.732532036069;5974.940250597482;5991.041433370661;4184.895377615553;4411.669124815636;6162.260528736558;6421.711023003976;6423.486121110323;6259.561830671855;6348.777792777254;6356.141920840697;6360.681965901709;6365.777197798078;6158.938410615881;6311.116443697886;6345;6354.555181137299;6365;3184.570083038783;5103;5519.365272993617;5520.917186242169;5528.778848846041;23461.178858739862;24055.879720601286;24581.770911454536;24586.172590152182;24603.892824822928;2141.1649456711893;2192.0464597899963;2247.292102987554;2303.516261585069;2630.316117809364;13751.243681597509;13813.309334533333;13840.446382144703;14417.449282026391;14447.422103115863;1669.6434346097824;1670.181611010596;1719.7936247650237;1763.8412542871074;1805.1154934082206;80199.5990020052;100268;101872.4719129221;103279.93440131155;104093;8534.74395768128;9967.252456065678;10048.748781280527;10246.641367552249;10288.176945844314;12731.745365092831;12779.297138657463;12803.551875684307;12808.615741527768;12863.42114604845;8400.285975692012;8454.196851299117;8487.321014318839;8487.618057187441;8594.828103437896;7744.535327880232;8742.781430464289;8805.383623146447;8813.471191728517;8884;5475.658463676425;5934.525237981037;5942.494887934487;5949;6158.230221222348;1531.3415231450583;1699.524133242694;1702.9148542572823;1779.3060706324286;1785.6875046866746;865.1910463716446;891.4027601507006;891.4205766251858;918.150710592699;976.3360914578155;17020.48938531846;19602.823830569927;19691.21235150578;19745;19845.801541984394;907.8002839375326;940.922643573105;1005.627917670452;1028.377831411985;1075.3386667199616;9436.905630943602;11025.669229923114;11271.492782824793;11286.379249141211;11286.54853805855;577255;616663;622916;637434;637568;94784;95507.52246238725;96299.51850240704;98363.50818245862;98397;1039.9428031458342;1065.63235683689;1073.0932362153967;1090.5256213547132;1091.317926296065;18203.816751911083;18404.539886502946;18416.263349466408;18450.07749612541;18608.2556697736;47538.72151506381;47994.520054799;48231.31190408319;48475.03049939052;49771.00457990892;55420;62459.687701563016;63492.04761928482;63615.27462528395;64066.785808513574;7523.774286771406;7880.290773830383;8012.439129261129;8046.028722962911;8048.758537243892;9197.724068277963;9759;11859.288442693465;12097.092718046006;12378.75242495127;9093.454392736458;11063.446827658745;11340.376279304388;11396.715082123013;11436.370999595103;8548.529830859363;10677.786444270916;10744.086752626114;10944.452777361259;11252.774944500901;9866.851997219905;9987.450690211817;11027.897210278908;11153.275037122561;11650.88349116498;7823.569703666353;7882.802929926797;7904.6442910068035;8010.319122874388;8244.093149753402;10473.476326183509;11238.988491035847;11366.772664546828;11388.94305528467;11420.486078126338 09:37:05 INFO - PROCESS | 2000 | |3;mootools.html;1362.9386677599507;1403.3474434388008;1566.4360830101166;1753.5177826097822;1950.5123719070223;7881.7241396551135;8576.785580360494;8751.3874028818;8756.299496040318;8758.34312426569;8431;8701;8715.869261961076;8716.564171791417;8731.476111433318;2150.7204063471727;2218.234709025384;2220.666899965002;2453.19044715244;2484.6769919910475;2424.903003879843;2494.1519883239694;2494.251724482648;2495.0019992003163;2495.6007038873786;2428.574999375111;2461.5323088613195;2465.5561998840203;2471.542764588548;2487.751224877516;2429.3440770991733;2457.1400009996537;2475.1955614425383;2478.5414698280697;2492.962605560918;2449.6815413996246;2475.170817776047;2482.7641374069435;2483.7019557653016;2492.3644470660047;7291.4531410144455;8690.95708514976;8717;8726.171013753683;8740.3444741644;5307.893842123174;5465.699386533739;5496.31296087989;5499.560035197174;5511.807086751945;3499.91250218744;3569.8750543730844;3635.1275693833554;3635.1820840310984;3637.909052273688;990.5542505872386;1018.5976539266948;1042.4631314872847;1045.1121826804276;1062.585591619269;11720.472578733892;11739.765204695943;11743.94304512598;11752.059835213162;11776.998955088828;4063.4514340564238;4775.092732380836;4791.592714619227;4822.132016237041;4844.442889067732;9865.605375784888;9910.256730745223;9921.65274215399;9927;9945.602175913027;5439.129739241703;5483.245361484287;5484.177373394023;5492.670439773627;5495.450454954473;4393.428854248928;4534.161180181677;4824.252240902666;4985.376827896513;4999.200127979506;3785.621437856192;3810.2950954073585;3862.633049860259;3864.9227015460096;3864.942025869614;1304.5499302740538;1308.3131356037966;1312.5996571045923;1325.9535916242885;1328.4885319152004;1081.5025088459397;1103.7626910214342;1104.2491106047803;1283.7881749511412;1405.7188562287583;7956.761297161094;8089.676412943416;8275.131111233355;8276.379271554657;8281.17188281167;1186.0867132308074;1189.6668932698858;1193.886580774825;1206.849143857018;1212.8362671039297;6279.403456671609;6296.496280297565;6305.684715764193;6316.842078948063;6328.6519241442165;9991.900080999243;10420.68737937863;10441.321314114559;10458.947705261426;10569.1503986802;8677.696280630147;10097.798044039078;10271.972802719669;10313.587456501657;10428.634997775192;7010.439164866799;8071.515709057476;8186.672533098728;8236.752897413087;8292.37807164465;7815.687372505036;7909.129995700583;7996.84006319882;8001.239882211181;8204.58977051157;9130.77173070652;9380.249580033718;9469.431834089977;9724.9027509724;9733.9026609733;8139.430239883151;9492.57283422234;9660.565274562521;9707.514624268617;9901.702948911545;6463.64449955257;6738.157730283715;6934.445244380337;6946.16646002483;7358.006669099817;7124.287571242834;7788.376929845712;7797.493162944391;7798.37612990948;7800.960995194988;7001.439884809305;7359;7373.262673732584;7495.250474952461;7541.095068591804;7163.355298022994;7237.529560578546;7329.047223861077;7358.11702595692;7406.07424071991;7649.61751912391;7682.270184332479;7710.036245469317;7712.035995500562;7755.2632499912415;6978.441724661913;6979.406750426067;7026.051483049927;7028;7050.224475307609;7112.431005519649;7113.039739635083;7177.820554485971;7196.784096477114;7206.531575447579 09:37:05 INFO - PROCESS | 2000 | |4;prototype.html;318.94896816509356;323.1114435302917;327.22937482229344;333.63800276699794;337.1571072319202;6454.741810327593;6460.741570337181;6469.70886310116;6500.739970401179;6507.284198738141;5141.948580514194;6369;6449.484041276698;6480.611163330203;6497.902531462032;4575.725456472605;4636.675432719711;4682.719036857782;4688.273317635755;4799.376081109451;4710.105080034799;4756.7859446325;4773.594244489223;4775.594074503671;4791.161546729309;4619.884502887421;4716.693414928036;4717.127331443677;4760.262159365287;4763.809447622091;4508.331917190628;4580.129775342674;4682.906341873144;4762.833300834472;4763.452202996647;4040.333344998072;4046.433499310099;4047.98800299925;4050.7164498485117;4060.7563546187325;4590.839320623762;5976.073708575134;6049.425304596057;6137.877242455126;6188.659623720693;5524.751386187631;5533.253010843525;5535.501804837544;5546.195801608785;5548.334199896039;6812.14848143982;6816.625085620289;6818.147731533559;6821.045053692487;6844.93155068448;3809.904752381213;4363.716358436692;4523.0275490769645;4548.977255113737;4550.704204226715;7111.64441777909;7160.749373771945;7165.820854478679;7181.856362872765;7183.604901730403;4641;4646.697964632288;4648.279516674921;4649.325847752057;4664.603508701798;3945.928387596535;4731.905361892743;4742.051589682008;4752.429708434941;4758.3100450434495;5540.058190107691;5542.362628297717;5545.334559852843;5549.361823390362;5549.72251387429;6643.800685979429;6876.621785801829;6883.27725588806;6885.518013739091;6888.173419189629;1585.9127747973741;1593.6334643031935;1604.254021879808;1608.8310727373691;1611.2829790743008;1006.285537268533;1007.6825799873017;1028.4908970059869;1031.6131450705984;1032.055669062814;4998.275250088789;5065.544101030925;6257.9687101564205;6317.210348706411;6328.715207815567;6970.372666459942;7063.187733410621;7092.716291348392;7100.68046937889;7139.750108746169;6376.426121649074;6385.712642931079;6397.392247736458;6402.135711678864;6403.071554624554;3756.2299728556127;3797.0697179191275;3797.696184305249;3823.0633494793396;3827.5406951165482;6118.663473509;6550.377714117151;7125.859862422091;7148.892766608505;7442.9255707442235;7368.078990126234;7394.7781566553085;7409.666565004588;7415.962920185472;7425.740099096506;7451.1431185413285;7452.217517160729;7457.925420745832;7476.626168691544;7499.5875226863045;7154.928450715426;7184.497085204194;7190.209077001421;7192.460565457507;7199.676014579251;6790.93209067903;7026.578405295494;7049.859002820018;7078;7098.751543695946;6043.425874541911;7432.368248698921;7442.255774422514;7446.515976461513;7457.776266712007;4585.793639286173;4587.977060114678;4595.264757638762;4604.263317869125;4606.282293446749;5839.649621022752;7093.751718689821;7105.573665579875;7113.53762005468;7120.359167674727;6619.238787539302;6852.6231057292325;6908.171019477695;6941.201761797256;6941.34057264559;6834.2482326943;6881.89677154833;6885.242623311532;6898.689558969758;6902.447804175755;6738.157730283715;6746.224184218681;6759.695813688298;6763.830904227237;6776;6904.13698287714;6920.446364290945;6932.930670693228;6946.2011868635755;6951.409130223786;6443.613383197023;6463.418292353711;6746.291639377795;6747.359000894907;6769.526133170828 09:37:05 INFO - PROCESS | 2000 | |5;yui.html;677.4546490075488;733.5195446982228;745.7986343687209;765.3303359560383;779.0456690554072;14631.487897923575;14956.77564836527;14977.700445991073;14995.325210365532;15044.94685372023;13497.325133743298;13504.459821607124;13589.32053397331;13594.048416610816;13609.251491167981;770.1797585571377;895.5925054100401;908.4640062363204;913.55235934392;915.8763566918448;888.1695614600369;904.4618452021037;905.1582028713294;907.1654078248027;907.9046700096494;952.1716106986931;953.408886490377;956.1442508954482;956.9856452153223;958.0850287974968;944.2257348973844;944.5182956692067;945.0738276489011;946.8816397950291;946.9772645542797;706.3783870194247;707.0313670271761;707.4587940225731;708.1961973160448;708.727140051084;13308;13417.530386436525;13433.328333583282;13437.66405839852;13457.394417251247;11296.265742726779;11642.301461912313;11656.533738650443;11865.110116741278;12080.818787718192;10733.355998640107;10972.341659500455;11041.668749937515;11168.609098681507;11678.649640510714;3328.2438192244404;3516.103894814697;3545.6986156176754;3627.891163265106;3643.7813731176216;73220.63389683071;73791.52416951685;73821.89267160997;73905;74013.25986740172;9081.455112693127;9134.497602631785;9161.954190229006;9450.385724927857;9462.858057129148;19937.401877943685;20068.598628027357;20073.397798066082;20102.69845952312;20116.798832011784;7146.535475194096;7273.3817625502425;7285.854282914312;7412.518186317872;7443.367313778282;3958.782266975344;4003.339448990942;4013.538443079025;4014.277430062617;4016.9957510622344;3209.951850722241;3339.7475946520053;3472.6700963408434;3530.435130379127;3539.628339024417;606.8088552106072;618.1191801682585;625.4121126141413;635.6281575278422;635.7933671556763;485.8178183181307;557.5567423897929;594.9077892926604;616.1949959003227;616.2050954268943;6200.364844940882;6693;8053.436259461899;8097.919020809834;8180.590970451453;578.6904006356663;604.8487878030493;605.6608299352289;605.9666718330534;623.183629445428;2833.5891295762412;3555.8577656893954;3793.962060379416;3823.5220597425323;4018.6939244745577;81815.59092204501;82636.58681706553;83260;83272.58363708264;84761;55715;70541.2945870545;70756.58486830235;70829.29170708227;70999.2900071003;58418.70790646019;64511;65020.67489662616;65203.021954670716;65423.672881635284;8101.554414507023;8149.755507334789;8279.130691277329;8358.414910956175;8405.369597280107;46011;48057.279140812214;48339.516604834906;49922.75193120201;51533.13501487328;65486;66764.6661766688;70197;70372;72254;11726.94136529312;11792.23350482216;11875.168738188244;11946.462409191434;12197.207181533173;11994.520219191483;12007.579734709243;12054.975327096945;12215.938920305342;12420.689482763004;11419.657410277705;11565.826512602485;11655.30068195911;11745.706357341134;11821.527138914347;11465;11789.351585662871;11850.111241657083;12043.156979011384;12271.938640306742;11621.825672615087;11629.76740465169;11667.941660291644;12052.397380131133;12259.632211033684;6878.219637352192;7909.52542847431;9091.272698183997;9288.72133835986;9341.859872102059;9273.953630231807;9688.12806847387;9690.854637180308;9727;9737.756556086155 09:37:05 INFO - PROCESS | 2000 | __end_tp_report 09:37:05 INFO - PROCESS | 2000 | __start_cc_report 09:37:05 INFO - PROCESS | 2000 | _x_x_mozilla_cycle_collect,1357 09:37:05 INFO - PROCESS | 2000 | __end_cc_report 09:37:05 INFO - PROCESS | 2000 | __startTimestamp1460047025700__endTimestamp 09:37:05 INFO - PROCESS | 2000 | 09:37:05 INFO - PROCESS | 2000 | ------- Summary: start ------- 09:37:05 INFO - PROCESS | 2000 | Number of tests: 6 09:37:05 INFO - PROCESS | 2000 | 09:37:05 INFO - PROCESS | 2000 | [#0] dojo.html Cycles:165 Average:5719.11 Median:6012.19 stddev:631.96 (10.5%) stddev-sans-first:607.47 09:37:05 INFO - PROCESS | 2000 | Values: 3413.5 3454.6 3486.3 3498.2 3548.3 5600.4 5750.3 5801.2 5816.7 5818.9 5652.9 5734.2 5778.6 5794.8 5807.3 4373.3 4566.9 4935.1 5148.4 5167.5 5232.3 5242.7 5244.1 5258.4 5267.5 4715.6 5176.5 5209.7 5231.7 5234.2 4891.9 5250.3 5255.0 5259.6 5318.4 5092.7 5100.5 5152.3 5178.4 5179.8 5121.8 5395.4 5620.6 5640.3 5643.3 6114.0 6134.8 6140.4 6149.1 6163.2 6124.4 6126.0 6192.6 6204.5 6216.2 5939.3 5973.8 5991.8 6005.1 6024.9 6239.0 6239.1 6271.8 6276.2 6280.4 5934.9 6122.8 6131.0 6147.3 6164.7 6105.6 6162.8 6166.8 6174.0 6186.1 6081.4 6127.9 6136.9 6157.0 6170.4 6100.1 6127.6 6167.7 6188.8 6192.6 4929.2 4942.6 4942.7 4947.4 4958.9 4411.5 4463.1 4481.0 4491.7 4514.3 5650.0 5711.9 5723.6 5741.3 5771.5 6168.6 6171.6 6187.0 6193.0 6208.1 5538.7 5632.0 5637.2 5701.2 5731.7 5384.1 5401.5 5408.7 5413.7 5421.4 5291.3 6235.0 6238.7 6247.1 6282.4 6180.9 6192.3 6192.6 6197.1 6204.3 5812.2 6306.2 6314.3 6316.0 6322.9 6108.5 6144.0 6151.2 6195.8 6228.6 6119.7 6179.8 6207.7 6208.2 6218.1 6098.7 6142.9 6144.3 6184.7 6189.6 6009.9 6095.5 6132.3 6139.9 6144.6 6012.2 6037.8 6040.5 6047.6 6098.1 6136.4 6148.1 6149.1 6156.5 6177.2 5911.7 5926.4 5949.0 5962.8 6029.7 09:37:05 INFO - PROCESS | 2000 | 09:37:05 INFO - PROCESS | 2000 | [#1] ext.html Cycles:180 Average:68773.52 Median:37899.13 stddev:149485.41 (394.4%) stddev-sans-first:149816.76 09:37:05 INFO - PROCESS | 2000 | Values: 456.9 531.4 569.6 629.3 631.5 30268.2 33063.3 38615.0 38644.4 39038.6 42254.8 42461.0 42651.7 42771.8 42812.8 9361.4 9584.4 9603.9 9608.2 9614.1 9438.6 9592.6 9598.1 9612.9 9711.0 9605.0 9701.2 9715.0 9718.1 9731.6 8440.6 9616.8 9706.6 9717.7 9742.7 9424.0 9440.7 9504.4 9573.0 9586.3 40948.6 41150.2 41202.4 41223.6 41230.0 3132.4 3183.4 3215.6 3218.6 3417.8 23935.8 27054.5 27789.0 28626.0 28693.0 2668.0 2723.0 2749.8 2817.2 2868.9 502783.0 510713.0 511386.0 512171.4 513142.0 68361.0 69635.7 70293.0 70928.6 70989.0 73266.0 73363.6 73410.3 73413.3 73422.6 17306.4 17598.7 17608.8 17617.2 17632.0 11805.4 12188.2 12212.3 12247.9 13025.5 15827.4 21971.7 22246.2 22276.9 22304.0 8705.4 8838.6 9279.6 9488.7 9571.1 922.3 928.7 995.5 1123.7 1171.9 29055.7 29326.9 29716.7 29821.3 30752.4 1031.1 1039.4 1060.7 1070.5 1142.2 14543.4 14648.9 14729.3 14931.5 15032.9 665873.0 666129.3 676927.0 677619.0 678048.0 60441.7 61175.0 61251.7 61278.1 61497.7 1327.4 1436.1 1444.1 1465.6 1467.2 28756.6 28811.6 29453.6 29824.5 30325.0 50236.0 50760.7 50891.0 50898.5 50925.7 411179.0 425444.0 426541.0 426541.0 636018.0 32872.0 33378.0 33843.0 34375.0 34394.0 36798.6 37183.3 40956.3 41770.6 42287.4 34859.5 35022.3 35098.8 35679.3 35812.8 34356.3 34563.7 34893.1 35093.9 35134.6 34741.0 34770.3 35168.0 35731.5 36479.8 30018.7 30901.4 30958.4 30996.8 31004.7 23508.1 23654.3 24152.6 24200.9 24316.0 09:37:05 INFO - PROCESS | 2000 | 09:37:05 INFO - PROCESS | 2000 | [#2] jquery.html Cycles:180 Average:33456.44 Median:362.03 stddev:101875.12 (28139.7%) stddev-sans-first:102130.60 09:37:05 INFO - PROCESS | 2000 | Values: 361.9 361.9 362.2 372.0 373.3 19586.0 20153.4 20340.3 20877.0 20882.8 19305.6 20033.9 20576.8 20637.3 20692.9 5710.0 5926.2 5943.7 5974.9 5991.0 4184.9 4411.7 6162.3 6421.7 6423.5 6259.6 6348.8 6356.1 6360.7 6365.8 6158.9 6311.1 6345.0 6354.6 6365.0 3184.6 5103.0 5519.4 5520.9 5528.8 23461.2 24055.9 24581.8 24586.2 24603.9 2141.2 2192.0 2247.3 2303.5 2630.3 13751.2 13813.3 13840.4 14417.4 14447.4 1669.6 1670.2 1719.8 1763.8 1805.1 80199.6 100268.0 101872.5 103279.9 104093.0 8534.7 9967.3 10048.7 10246.6 10288.2 12731.7 12779.3 12803.6 12808.6 12863.4 8400.3 8454.2 8487.3 8487.6 8594.8 7744.5 8742.8 8805.4 8813.5 8884.0 5475.7 5934.5 5942.5 5949.0 6158.2 1531.3 1699.5 1702.9 1779.3 1785.7 865.2 891.4 891.4 918.2 976.3 17020.5 19602.8 19691.2 19745.0 19845.8 907.8 940.9 1005.6 1028.4 1075.3 9436.9 11025.7 11271.5 11286.4 11286.5 577255.0 616663.0 622916.0 637434.0 637568.0 94784.0 95507.5 96299.5 98363.5 98397.0 1039.9 1065.6 1073.1 1090.5 1091.3 18203.8 18404.5 18416.3 18450.1 18608.3 47538.7 47994.5 48231.3 48475.0 49771.0 55420.0 62459.7 63492.0 63615.3 64066.8 7523.8 7880.3 8012.4 8046.0 8048.8 9197.7 9759.0 11859.3 12097.1 12378.8 9093.5 11063.4 11340.4 11396.7 11436.4 8548.5 10677.8 10744.1 10944.5 11252.8 9866.9 9987.5 11027.9 11153.3 11650.9 7823.6 7882.8 7904.6 8010.3 8244.1 10473.5 11239.0 11366.8 11388.9 11420.5 09:37:05 INFO - PROCESS | 2000 | 09:37:05 INFO - PROCESS | 2000 | [#3] mootools.html Cycles:180 Average:5953.38 Median:5505.68 stddev:3095.63 (56.2%) stddev-sans-first:3085.08 09:37:05 INFO - PROCESS | 2000 | Values: 1362.9 1403.3 1566.4 1753.5 1950.5 7881.7 8576.8 8751.4 8756.3 8758.3 8431.0 8701.0 8715.9 8716.6 8731.5 2150.7 2218.2 2220.7 2453.2 2484.7 2424.9 2494.2 2494.3 2495.0 2495.6 2428.6 2461.5 2465.6 2471.5 2487.8 2429.3 2457.1 2475.2 2478.5 2493.0 2449.7 2475.2 2482.8 2483.7 2492.4 7291.5 8691.0 8717.0 8726.2 8740.3 5307.9 5465.7 5496.3 5499.6 5511.8 3499.9 3569.9 3635.1 3635.2 3637.9 990.6 1018.6 1042.5 1045.1 1062.6 11720.5 11739.8 11743.9 11752.1 11777.0 4063.5 4775.1 4791.6 4822.1 4844.4 9865.6 9910.3 9921.7 9927.0 9945.6 5439.1 5483.2 5484.2 5492.7 5495.5 4393.4 4534.2 4824.3 4985.4 4999.2 3785.6 3810.3 3862.6 3864.9 3864.9 1304.5 1308.3 1312.6 1326.0 1328.5 1081.5 1103.8 1104.2 1283.8 1405.7 7956.8 8089.7 8275.1 8276.4 8281.2 1186.1 1189.7 1193.9 1206.8 1212.8 6279.4 6296.5 6305.7 6316.8 6328.7 9991.9 10420.7 10441.3 10458.9 10569.2 8677.7 10097.8 10272.0 10313.6 10428.6 7010.4 8071.5 8186.7 8236.8 8292.4 7815.7 7909.1 7996.8 8001.2 8204.6 9130.8 9380.2 9469.4 9724.9 9733.9 8139.4 9492.6 9660.6 9707.5 9901.7 6463.6 6738.2 6934.4 6946.2 7358.0 7124.3 7788.4 7797.5 7798.4 7801.0 7001.4 7359.0 7373.3 7495.3 7541.1 7163.4 7237.5 7329.0 7358.1 7406.1 7649.6 7682.3 7710.0 7712.0 7755.3 6978.4 6979.4 7026.1 7028.0 7050.2 7112.4 7113.0 7177.8 7196.8 7206.5 09:37:05 INFO - PROCESS | 2000 | 09:37:05 INFO - PROCESS | 2000 | [#4] prototype.html Cycles:180 Average:5595.43 Median:6381.07 stddev:1783.84 (28.0%) stddev-sans-first:1744.32 09:37:05 INFO - PROCESS | 2000 | Values: 318.9 323.1 327.2 333.6 337.2 6454.7 6460.7 6469.7 6500.7 6507.3 5141.9 6369.0 6449.5 6480.6 6497.9 4575.7 4636.7 4682.7 4688.3 4799.4 4710.1 4756.8 4773.6 4775.6 4791.2 4619.9 4716.7 4717.1 4760.3 4763.8 4508.3 4580.1 4682.9 4762.8 4763.5 4040.3 4046.4 4048.0 4050.7 4060.8 4590.8 5976.1 6049.4 6137.9 6188.7 5524.8 5533.3 5535.5 5546.2 5548.3 6812.1 6816.6 6818.1 6821.0 6844.9 3809.9 4363.7 4523.0 4549.0 4550.7 7111.6 7160.7 7165.8 7181.9 7183.6 4641.0 4646.7 4648.3 4649.3 4664.6 3945.9 4731.9 4742.1 4752.4 4758.3 5540.1 5542.4 5545.3 5549.4 5549.7 6643.8 6876.6 6883.3 6885.5 6888.2 1585.9 1593.6 1604.3 1608.8 1611.3 1006.3 1007.7 1028.5 1031.6 1032.1 4998.3 5065.5 6258.0 6317.2 6328.7 6970.4 7063.2 7092.7 7100.7 7139.8 6376.4 6385.7 6397.4 6402.1 6403.1 3756.2 3797.1 3797.7 3823.1 3827.5 6118.7 6550.4 7125.9 7148.9 7442.9 7368.1 7394.8 7409.7 7416.0 7425.7 7451.1 7452.2 7457.9 7476.6 7499.6 7154.9 7184.5 7190.2 7192.5 7199.7 6790.9 7026.6 7049.9 7078.0 7098.8 6043.4 7432.4 7442.3 7446.5 7457.8 4585.8 4588.0 4595.3 4604.3 4606.3 5839.6 7093.8 7105.6 7113.5 7120.4 6619.2 6852.6 6908.2 6941.2 6941.3 6834.2 6881.9 6885.2 6898.7 6902.4 6738.2 6746.2 6759.7 6763.8 6776.0 6904.1 6920.4 6932.9 6946.2 6951.4 6443.6 6463.4 6746.3 6747.4 6769.5 09:37:05 INFO - PROCESS | 2000 | 09:37:05 INFO - PROCESS | 2000 | [#5] yui.html Cycles:180 Average:17284.95 Median:616.20 stddev:23570.76 (3825.2%) stddev-sans-first:23603.90 09:37:05 INFO - PROCESS | 2000 | Values: 677.5 733.5 745.8 765.3 779.0 14631.5 14956.8 14977.7 14995.3 15044.9 13497.3 13504.5 13589.3 13594.0 13609.3 770.2 895.6 908.5 913.6 915.9 888.2 904.5 905.2 907.2 907.9 952.2 953.4 956.1 957.0 958.1 944.2 944.5 945.1 946.9 947.0 706.4 707.0 707.5 708.2 708.7 13308.0 13417.5 13433.3 13437.7 13457.4 11296.3 11642.3 11656.5 11865.1 12080.8 10733.4 10972.3 11041.7 11168.6 11678.6 3328.2 3516.1 3545.7 3627.9 3643.8 73220.6 73791.5 73821.9 73905.0 74013.3 9081.5 9134.5 9162.0 9450.4 9462.9 19937.4 20068.6 20073.4 20102.7 20116.8 7146.5 7273.4 7285.9 7412.5 7443.4 3958.8 4003.3 4013.5 4014.3 4017.0 3210.0 3339.7 3472.7 3530.4 3539.6 606.8 618.1 625.4 635.6 635.8 485.8 557.6 594.9 616.2 616.2 6200.4 6693.0 8053.4 8097.9 8180.6 578.7 604.8 605.7 606.0 623.2 2833.6 3555.9 3794.0 3823.5 4018.7 81815.6 82636.6 83260.0 83272.6 84761.0 55715.0 70541.3 70756.6 70829.3 70999.3 58418.7 64511.0 65020.7 65203.0 65423.7 8101.6 8149.8 8279.1 8358.4 8405.4 46011.0 48057.3 48339.5 49922.8 51533.1 65486.0 66764.7 70197.0 70372.0 72254.0 11726.9 11792.2 11875.2 11946.5 12197.2 11994.5 12007.6 12055.0 12215.9 12420.7 11419.7 11565.8 11655.3 11745.7 11821.5 11465.0 11789.4 11850.1 12043.2 12271.9 11621.8 11629.8 11667.9 12052.4 12259.6 6878.2 7909.5 9091.3 9288.7 9341.9 9274.0 9688.1 9690.9 9727.0 9737.8 09:37:05 INFO - PROCESS | 2000 | -------- Summary: end -------- 09:37:05 INFO - PROCESS | 2000 | 09:37:06 INFO - TEST-INFO | 2000: exit 0 09:37:06 INFO - TEST-OK | dromaeo_css | took 1114848ms 09:37:06 INFO - TEST-START | kraken 09:37:06 INFO - operating with platform_type : mac_ 09:37:06 INFO - Initialising browser for kraken test... 09:37:06 INFO - TEST-INFO | started process 2004 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/tmpf_lc2M/profile http://localhost:49490/getInfo.html) 09:37:08 INFO - PROCESS | 2004 | __metrics Screen width/height:1600/1200 09:37:08 INFO - PROCESS | 2004 | colorDepth:24 09:37:08 INFO - PROCESS | 2004 | Browser inner width/height: 1024/689 09:37:08 INFO - PROCESS | 2004 | __metrics 09:37:08 INFO - PROCESS | 2004 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:37:08 ERROR - PROCESS | 2004 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:37:09 INFO - TEST-INFO | 2004: exit 0 09:37:09 INFO - Browser initialized. 09:37:09 INFO - Running cycle 1/1 for kraken test... 09:37:09 INFO - TEST-INFO | started process 2006 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/tmpf_lc2M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:37:21 INFO - PROCESS | 2006 | RSS: Main: 236425216 09:37:21 INFO - PROCESS | 2006 | 09:37:23 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49490/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49490/tests/kraken/driver.html?testName=audio-beat-detection) 09:37:24 INFO - PROCESS | 2006 | RSS: Main: 282894336 09:37:24 INFO - PROCESS | 2006 | 09:37:27 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49490/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49490/tests/kraken/driver.html?testName=audio-dft) 09:37:27 INFO - PROCESS | 2006 | RSS: Main: 294649856 09:37:27 INFO - PROCESS | 2006 | 09:37:30 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49490/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49490/tests/kraken/driver.html?testName=audio-fft) 09:37:31 INFO - PROCESS | 2006 | RSS: Main: 282406912 09:37:31 INFO - PROCESS | 2006 | 09:37:33 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49490/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49490/tests/kraken/driver.html?testName=audio-oscillator) 09:37:34 INFO - PROCESS | 2006 | RSS: Main: 284479488 09:37:34 INFO - PROCESS | 2006 | 09:37:36 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49490/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49490/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:37:36 INFO - PROCESS | 2006 | RSS: Main: 284663808 09:37:36 INFO - PROCESS | 2006 | 09:37:39 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49490/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49490/tests/kraken/driver.html?testName=imaging-darkroom) 09:37:40 INFO - PROCESS | 2006 | RSS: Main: 284667904 09:37:40 INFO - PROCESS | 2006 | 09:37:42 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49490/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49490/tests/kraken/driver.html?testName=imaging-desaturate) 09:37:43 INFO - PROCESS | 2006 | RSS: Main: 284774400 09:37:43 INFO - PROCESS | 2006 | 09:37:46 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49490/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49490/tests/kraken/driver.html?testName=json-parse-financial) 09:37:46 INFO - PROCESS | 2006 | RSS: Main: 285241344 09:37:46 INFO - PROCESS | 2006 | 09:37:48 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49490/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49490/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:37:49 INFO - PROCESS | 2006 | RSS: Main: 317820928 09:37:49 INFO - PROCESS | 2006 | 09:37:51 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49490/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49490/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:37:51 INFO - PROCESS | 2006 | RSS: Main: 317497344 09:37:51 INFO - PROCESS | 2006 | 09:37:53 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49490/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49490/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:37:54 INFO - PROCESS | 2006 | RSS: Main: 323444736 09:37:54 INFO - PROCESS | 2006 | 09:37:57 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49490/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49490/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:37:57 INFO - PROCESS | 2006 | RSS: Main: 324460544 09:37:57 INFO - PROCESS | 2006 | 09:38:00 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49490/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49490/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:38:00 INFO - PROCESS | 2006 | RSS: Main: 324689920 09:38:00 INFO - PROCESS | 2006 | 09:38:02 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49490/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49490/tests/kraken/driver.html?testName=ai-astar) 09:38:02 INFO - PROCESS | 2006 | RSS: Main: 387366912 09:38:02 INFO - PROCESS | 2006 | 09:38:02 INFO - PROCESS | 2006 | __start_tp_report 09:38:02 INFO - PROCESS | 2006 | _x_x_mozilla_page_load 09:38:02 INFO - PROCESS | 2006 | _x_x_mozilla_page_load_details 09:38:02 INFO - PROCESS | 2006 | |i|pagename|runs| 09:38:02 INFO - PROCESS | 2006 | |0;ai-astar;111;107;111;110;111;112;116;111;109;111 09:38:02 INFO - PROCESS | 2006 | |1;audio-beat-detection;186;155;140;162;118;177;168;120;162;122 09:38:02 INFO - PROCESS | 2006 | |2;audio-dft;186;186;188;186;183;183;185;182;182;180 09:38:02 INFO - PROCESS | 2006 | |3;audio-fft;77;77;84;80;56;58;57;76;79;56 09:38:02 INFO - PROCESS | 2006 | |4;audio-oscillator;92;97;134;79;78;81;119;80;78;122 09:38:02 INFO - PROCESS | 2006 | |5;imaging-gaussian-blur;88;86;90;88;89;86;87;88;89;86 09:38:02 INFO - PROCESS | 2006 | |6;imaging-darkroom;117;95;95;96;96;95;95;97;95;95 09:38:02 INFO - PROCESS | 2006 | |7;imaging-desaturate;85;85;84;85;84;84;84;86;85;84 09:38:02 INFO - PROCESS | 2006 | |8;json-parse-financial;52;52;71;78;78;80;69;65;55;50 09:38:02 INFO - PROCESS | 2006 | |9;json-stringify-tinderbox;65;71;68;74;73;68;69;69;69;91 09:38:02 INFO - PROCESS | 2006 | |10;stanford-crypto-aes;101;98;108;109;81;80;83;81;83;85 09:38:02 INFO - PROCESS | 2006 | |11;stanford-crypto-ccm;111;137;133;140;127;121;121;124;131;126 09:38:02 INFO - PROCESS | 2006 | |12;stanford-crypto-pbkdf2;141;130;139;139;141;128;139;139;141;139 09:38:02 INFO - PROCESS | 2006 | |13;stanford-crypto-sha256-iterative;68;67;66;70;90;91;91;94;66;66 09:38:02 INFO - PROCESS | 2006 | __end_tp_report 09:38:02 INFO - PROCESS | 2006 | __start_cc_report 09:38:02 INFO - PROCESS | 2006 | _x_x_mozilla_cycle_collect,1282 09:38:02 INFO - PROCESS | 2006 | __end_cc_report 09:38:02 INFO - PROCESS | 2006 | __startTimestamp1460047082931__endTimestamp 09:38:02 INFO - PROCESS | 2006 | 09:38:02 INFO - PROCESS | 2006 | ------- Summary: start ------- 09:38:02 INFO - PROCESS | 2006 | Number of tests: 14 09:38:02 INFO - PROCESS | 2006 | 09:38:02 INFO - PROCESS | 2006 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:2.28 (2.1%) stddev-sans-first:2.42 09:38:02 INFO - PROCESS | 2006 | Values: 111.0 107.0 111.0 110.0 111.0 112.0 116.0 111.0 109.0 111.0 09:38:02 INFO - PROCESS | 2006 | 09:38:02 INFO - PROCESS | 2006 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:162.00 stddev:24.63 (15.2%) stddev-sans-first:22.64 09:38:02 INFO - PROCESS | 2006 | Values: 186.0 155.0 140.0 162.0 118.0 177.0 168.0 120.0 162.0 122.0 09:38:02 INFO - PROCESS | 2006 | 09:38:02 INFO - PROCESS | 2006 | [#2] audio-dft Cycles:10 Average:184.10 Median:185.50 stddev:2.47 (1.3%) stddev-sans-first:2.52 09:38:02 INFO - PROCESS | 2006 | Values: 186.0 186.0 188.0 186.0 183.0 183.0 185.0 182.0 182.0 180.0 09:38:02 INFO - PROCESS | 2006 | 09:38:02 INFO - PROCESS | 2006 | [#3] audio-fft Cycles:10 Average:70.00 Median:77.00 stddev:11.62 (15.1%) stddev-sans-first:12.05 09:38:02 INFO - PROCESS | 2006 | Values: 77.0 77.0 84.0 80.0 56.0 58.0 57.0 76.0 79.0 56.0 09:38:02 INFO - PROCESS | 2006 | 09:38:02 INFO - PROCESS | 2006 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:79.50 stddev:21.30 (26.8%) stddev-sans-first:22.55 09:38:02 INFO - PROCESS | 2006 | Values: 92.0 97.0 134.0 79.0 78.0 81.0 119.0 80.0 78.0 122.0 09:38:02 INFO - PROCESS | 2006 | 09:38:02 INFO - PROCESS | 2006 | [#5] imaging-gaussian-blur Cycles:10 Average:87.70 Median:88.00 stddev:1.42 (1.6%) stddev-sans-first:1.50 09:38:02 INFO - PROCESS | 2006 | Values: 88.0 86.0 90.0 88.0 89.0 86.0 87.0 88.0 89.0 86.0 09:38:02 INFO - PROCESS | 2006 | 09:38:02 INFO - PROCESS | 2006 | [#6] imaging-darkroom Cycles:10 Average:97.60 Median:95.00 stddev:6.85 (7.2%) stddev-sans-first:0.73 09:38:02 INFO - PROCESS | 2006 | Values: 117.0 95.0 95.0 96.0 96.0 95.0 95.0 97.0 95.0 95.0 09:38:02 INFO - PROCESS | 2006 | 09:38:02 INFO - PROCESS | 2006 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 09:38:02 INFO - PROCESS | 2006 | Values: 85.0 85.0 84.0 85.0 84.0 84.0 84.0 86.0 85.0 84.0 09:38:02 INFO - PROCESS | 2006 | 09:38:02 INFO - PROCESS | 2006 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:70.00 stddev:11.92 (17.0%) stddev-sans-first:11.67 09:38:02 INFO - PROCESS | 2006 | Values: 52.0 52.0 71.0 78.0 78.0 80.0 69.0 65.0 55.0 50.0 09:38:02 INFO - PROCESS | 2006 | 09:38:02 INFO - PROCESS | 2006 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:70.00 stddev:7.26 (10.4%) stddev-sans-first:7.28 09:38:02 INFO - PROCESS | 2006 | Values: 65.0 71.0 68.0 74.0 73.0 68.0 69.0 69.0 69.0 91.0 09:38:02 INFO - PROCESS | 2006 | 09:38:02 INFO - PROCESS | 2006 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:82.00 stddev:11.77 (14.4%) stddev-sans-first:11.90 09:38:02 INFO - PROCESS | 2006 | Values: 101.0 98.0 108.0 109.0 81.0 80.0 83.0 81.0 83.0 85.0 09:38:02 INFO - PROCESS | 2006 | 09:38:02 INFO - PROCESS | 2006 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:129.00 stddev:8.56 (6.6%) stddev-sans-first:6.81 09:38:02 INFO - PROCESS | 2006 | Values: 111.0 137.0 133.0 140.0 127.0 121.0 121.0 124.0 131.0 126.0 09:38:02 INFO - PROCESS | 2006 | 09:38:02 INFO - PROCESS | 2006 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.60 Median:139.00 stddev:4.65 (3.3%) stddev-sans-first:4.76 09:38:02 INFO - PROCESS | 2006 | Values: 141.0 130.0 139.0 139.0 141.0 128.0 139.0 139.0 141.0 139.0 09:38:02 INFO - PROCESS | 2006 | 09:38:02 INFO - PROCESS | 2006 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.90 Median:80.00 stddev:12.66 (15.8%) stddev-sans-first:13.01 09:38:02 INFO - PROCESS | 2006 | Values: 68.0 67.0 66.0 70.0 90.0 91.0 91.0 94.0 66.0 66.0 09:38:02 INFO - PROCESS | 2006 | -------- Summary: end -------- 09:38:02 INFO - PROCESS | 2006 | 09:38:03 INFO - TEST-INFO | 2006: exit 0 09:38:03 INFO - TEST-OK | kraken | took 57402ms 09:38:03 INFO - SUITE-END | took 1172s 09:38:04 INFO - Completed test suite (00:19:32) 09:38:04 INFO - javascript benchmark 09:38:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3413.4879768034793, 3454.5681789776277, 3486.3027394521087, 3498.177928186877, 3548.343556442057, 5600.355959064709, 5750.252467179261, 5801.216835727176, 5816.651000939942, 5818.941810581893, 5652.925944070624, 5734.197212390269, 5778.595498315109, 5794.768209271635, 5807.274090738658, 4373.300271956487, 4566.885827854297, 4935.062338155757, 5148.3821941366905, 5167.509086636764, 5232.29364035856, 5242.711650859202, 5244.134717771563, 5258.44786297439, 5267.52592266696, 4715.552022557868, 5176.5341119299255, 5209.661372010826, 5231.712255825928, 5234.214867769827, 4891.902161956758, 5250.264962905158, 5255.0, 5259.5529380002745, 5318.388385335658, 5092.694438333675, 5100.464451232641, 5152.330197074394, 5178.352705911761, 5179.766910489037, 5121.795128194868, 5395.433479484676, 5620.606557540974, 5640.2667653205235, 5643.294588176478, 6114.0, 6134.8159555213415, 6140.4473597376, 6149.077638354238, 6163.19878415803, 6124.3809352984035, 6125.9892117800955, 6192.566520343577, 6204.503639708858, 6216.160818289518, 5939.346671866091, 5973.820785376446, 5991.7902873399225, 6005.129256257818, 6024.879502409927, 6238.968805155945, 6239.095331176954, 6271.7804876830005, 6276.215473065867, 6280.403361680633, 5934.910976335358, 6122.846928826815, 6131.040261761288, 6147.262328520606, 6164.6917654117115, 6105.572609917263, 6162.784302549389, 6166.81499555014, 6173.969130154321, 6186.133941248228, 6081.370449678783, 6127.938720612737, 6136.8772624547255, 6156.969215153896, 6170.444659980623, 6100.1270446244, 6127.571070025056, 6167.722452489649, 6188.783392581238, 6192.566520343623, 4929.186684197068, 4942.604591632661, 4942.654014219042, 4947.406311242674, 4958.9008219835405, 4411.514733379326, 4463.12968971054, 4481.036577135931, 4491.663125265618, 4514.345419914094, 5650.0, 5711.942880571224, 5723.570732195102, 5741.25363702716, 5771.451712087345, 6168.599041062316, 6171.6297022178815, 6187.010078387437, 6192.969035154795, 6208.0998255253635, 5538.667679939216, 5632.04255276604, 5637.210790489335, 5701.2018317435595, 5731.742071606787, 5384.057789886754, 5401.540869026098, 5408.729563521808, 5413.729313534308, 5421.403645598981, 5291.285676433709, 6234.9688251558455, 6238.719257633417, 6247.125402443661, 6282.434580887742, 6180.938190618216, 6192.256929168529, 6192.628442293477, 6197.101420294122, 6204.317525072329, 5812.244408226903, 6306.243250809932, 6314.305426403, 6316.0, 6322.873542529215, 6108.4807791338235, 6144.0, 6151.200343955436, 6195.845103872259, 6228.626282423069, 6119.715820550657, 6179.84550386244, 6207.6585787782105, 6208.2239720034995, 6218.098375735583, 6098.664573448325, 6142.938570614237, 6144.262688477412, 6184.659843708459, 6189.597676151036, 6009.909851352146, 6095.512359011357, 6132.264128304632, 6139.938600613937, 6144.569880108528, 6012.188354572252, 6037.758489660365, 6040.456358927718, 6047.606905551125, 6098.054801505774, 6136.355682653436, 6148.077788331786, 6149.108379285068, 6156.476699480594, 6177.166082578974, 5911.704414779329, 5926.407359264212, 5949.0, 5962.791302304398, 6029.728662210124], "unit": "score", "name": "dojo.html", "value": 5679.824111114452}, {"lowerIsBetter": false, "replicates": [456.910902374037, 531.4366771222502, 569.632586981397, 629.3077614623913, 631.4601016131207, 30268.24329391766, 33063.33873322532, 38615.0, 38644.42033369498, 39038.609613903885, 42254.7887260564, 42461.0, 42651.7204483866, 42771.78614106925, 42812.78593607035, 9361.391509551875, 9584.37701549397, 9603.855942160873, 9608.183304419097, 9614.086661767122, 9438.622455101788, 9592.616295348213, 9598.136167744902, 9612.9425763166, 9711.028897110267, 9604.951975240114, 9701.175400091, 9715.0, 9718.125368716814, 9731.610735570568, 8440.577971101482, 9616.80766384672, 9706.61173553057, 9717.659881904136, 9742.707718768448, 9423.952880235624, 9440.716778496657, 9504.4297342159, 9573.04269573044, 9586.281028922858, 40948.59051409477, 41150.1769964599, 41202.38196427056, 41223.587764122276, 41230.0, 3132.3891841090995, 3183.442897492953, 3215.565898603682, 3218.5976752905885, 3417.79493230407, 23935.76064239353, 27054.45891082187, 27789.0, 28626.0, 28693.0, 2667.9599806002925, 2722.992492777665, 2749.8212616180085, 2817.2393453767572, 2868.885244590214, 502783.0, 510712.9999999963, 511386.0, 512171.4391428019, 513141.9999999963, 68361.0, 69635.65182174159, 70293.0, 70928.64535677392, 70989.0, 73266.0, 73363.63318183481, 73410.26589734034, 73413.26586734172, 73422.63288683523, 17306.394276200273, 17598.736018959728, 17608.82391176072, 17617.207225674876, 17632.0, 11805.350705711096, 12188.207766495327, 12212.267263964191, 12247.877521224851, 13025.544105956436, 15827.402243349521, 21971.670424943637, 22246.221382251868, 22276.888615556818, 22303.996320165632, 8705.390622656354, 8838.55807209637, 9279.582418791171, 9488.667896623585, 9571.138597526256, 922.2852289475576, 928.6935311347239, 995.4922989275522, 1123.741539445932, 1171.8828117188214, 29055.70944290572, 29326.853365733463, 29716.702832971827, 29821.254468638024, 30752.384952301276, 1031.097789434245, 1039.449091981251, 1060.7295139739472, 1070.4594179939081, 1142.2461175624048, 14543.418263269563, 14648.85351146475, 14729.337179826933, 14931.477398291225, 15032.924835375972, 665873.0, 666129.3387066164, 676927.0, 677619.0, 678048.0, 60441.69779151076, 61175.0, 61251.6937415319, 61278.080828787606, 61497.69251153805, 1327.3694994877355, 1436.0593811053777, 1444.061360115933, 1465.5896349022291, 1467.2370367408887, 28756.568651469825, 28811.56782648304, 29453.558196627495, 29824.54388400082, 30325.0, 50236.0, 50760.74619626878, 50891.0, 50898.49101508938, 50925.745371272904, 411179.0, 425444.0, 426541.0, 426541.0, 636018.0, 32872.0, 33378.0, 33842.984710458724, 34375.0, 34393.96818095461, 36798.63201367952, 37183.256334873695, 40956.33783804043, 41770.58229417667, 42287.36568951407, 34859.47710784391, 35022.29955400929, 35098.82450587731, 35679.28641427209, 35812.82093589516, 34356.312873742885, 34563.654363456044, 34893.127671808405, 35093.94718158459, 35134.64865351416, 34740.957771266905, 34770.304593908484, 35168.0, 35731.46402803908, 36479.817600911825, 30018.69981300159, 30901.381972359977, 30958.38083238368, 30996.845015774776, 31004.689953101082, 23508.059677612702, 23654.290371288887, 24152.63771043471, 24200.878995605613, 24316.0], "unit": "score", "name": "ext.html", "value": 19959.349035921816}, {"lowerIsBetter": false, "replicates": [361.878770611845, 361.9131408461969, 362.15436954710765, 372.0160176333596, 373.342916467018, 19586.020698965065, 20153.395398138062, 20340.288089916874, 20877.0, 20882.791172088273, 19305.613887722273, 20033.898135602536, 20576.794232057677, 20637.277695280667, 20692.89653551734, 5709.971450142754, 5926.199963005004, 5943.732532036069, 5974.940250597482, 5991.041433370661, 4184.895377615553, 4411.669124815636, 6162.260528736558, 6421.711023003976, 6423.486121110323, 6259.561830671855, 6348.777792777254, 6356.141920840697, 6360.681965901709, 6365.777197798078, 6158.938410615881, 6311.116443697886, 6345.0, 6354.555181137299, 6365.0, 3184.570083038783, 5103.0, 5519.365272993617, 5520.917186242169, 5528.778848846041, 23461.178858739862, 24055.879720601286, 24581.770911454536, 24586.172590152182, 24603.892824822928, 2141.1649456711893, 2192.0464597899963, 2247.292102987554, 2303.516261585069, 2630.316117809364, 13751.243681597509, 13813.309334533333, 13840.446382144703, 14417.449282026391, 14447.422103115863, 1669.6434346097824, 1670.181611010596, 1719.7936247650237, 1763.8412542871074, 1805.1154934082206, 80199.5990020052, 100268.0, 101872.4719129221, 103279.93440131155, 104093.0, 8534.74395768128, 9967.252456065678, 10048.748781280527, 10246.641367552249, 10288.176945844314, 12731.745365092831, 12779.297138657463, 12803.551875684307, 12808.615741527768, 12863.42114604845, 8400.285975692012, 8454.196851299117, 8487.321014318839, 8487.618057187441, 8594.828103437896, 7744.535327880232, 8742.781430464289, 8805.383623146447, 8813.471191728517, 8884.0, 5475.658463676425, 5934.525237981037, 5942.494887934487, 5949.0, 6158.230221222348, 1531.3415231450583, 1699.524133242694, 1702.9148542572823, 1779.3060706324286, 1785.6875046866746, 865.1910463716446, 891.4027601507006, 891.4205766251858, 918.150710592699, 976.3360914578155, 17020.48938531846, 19602.823830569927, 19691.21235150578, 19745.0, 19845.801541984394, 907.8002839375326, 940.922643573105, 1005.627917670452, 1028.377831411985, 1075.3386667199616, 9436.905630943602, 11025.669229923114, 11271.492782824793, 11286.379249141211, 11286.54853805855, 577255.0, 616663.0, 622916.0, 637434.0, 637568.0, 94784.0, 95507.52246238725, 96299.51850240704, 98363.50818245862, 98397.0, 1039.9428031458342, 1065.63235683689, 1073.0932362153967, 1090.5256213547132, 1091.317926296065, 18203.816751911083, 18404.539886502946, 18416.263349466408, 18450.07749612541, 18608.2556697736, 47538.72151506381, 47994.520054799, 48231.31190408319, 48475.03049939052, 49771.00457990892, 55420.0, 62459.687701563016, 63492.04761928482, 63615.27462528395, 64066.785808513574, 7523.774286771406, 7880.290773830383, 8012.439129261129, 8046.028722962911, 8048.758537243892, 9197.724068277963, 9759.0, 11859.288442693465, 12097.092718046006, 12378.75242495127, 9093.454392736458, 11063.446827658745, 11340.376279304388, 11396.715082123013, 11436.370999595103, 8548.529830859363, 10677.786444270916, 10744.086752626114, 10944.452777361259, 11252.774944500901, 9866.851997219905, 9987.450690211817, 11027.897210278908, 11153.275037122561, 11650.88349116498, 7823.569703666353, 7882.802929926797, 7904.6442910068035, 8010.319122874388, 8244.093149753402, 10473.476326183509, 11238.988491035847, 11366.772664546828, 11388.94305528467, 11420.486078126338], "unit": "score", "name": "jquery.html", "value": 9307.154017333552}, {"lowerIsBetter": false, "replicates": [1362.9386677599507, 1403.3474434388008, 1566.4360830101166, 1753.5177826097822, 1950.5123719070223, 7881.7241396551135, 8576.785580360494, 8751.3874028818, 8756.299496040318, 8758.34312426569, 8431.0, 8701.0, 8715.869261961076, 8716.564171791417, 8731.476111433318, 2150.7204063471727, 2218.234709025384, 2220.666899965002, 2453.19044715244, 2484.6769919910475, 2424.903003879843, 2494.1519883239694, 2494.251724482648, 2495.0019992003163, 2495.6007038873786, 2428.574999375111, 2461.5323088613195, 2465.5561998840203, 2471.542764588548, 2487.751224877516, 2429.3440770991733, 2457.1400009996537, 2475.1955614425383, 2478.5414698280697, 2492.962605560918, 2449.6815413996246, 2475.170817776047, 2482.7641374069435, 2483.7019557653016, 2492.3644470660047, 7291.4531410144455, 8690.95708514976, 8717.0, 8726.171013753683, 8740.3444741644, 5307.893842123174, 5465.699386533739, 5496.31296087989, 5499.560035197174, 5511.807086751945, 3499.91250218744, 3569.8750543730844, 3635.1275693833554, 3635.1820840310984, 3637.909052273688, 990.5542505872386, 1018.5976539266948, 1042.4631314872847, 1045.1121826804276, 1062.585591619269, 11720.472578733892, 11739.765204695943, 11743.94304512598, 11752.059835213162, 11776.998955088828, 4063.4514340564238, 4775.092732380836, 4791.592714619227, 4822.132016237041, 4844.442889067732, 9865.605375784888, 9910.256730745223, 9921.65274215399, 9927.0, 9945.602175913027, 5439.129739241703, 5483.245361484287, 5484.177373394023, 5492.670439773627, 5495.450454954473, 4393.428854248928, 4534.161180181677, 4824.252240902666, 4985.376827896513, 4999.200127979506, 3785.621437856192, 3810.2950954073585, 3862.633049860259, 3864.9227015460096, 3864.942025869614, 1304.5499302740538, 1308.3131356037966, 1312.5996571045923, 1325.9535916242885, 1328.4885319152004, 1081.5025088459397, 1103.7626910214342, 1104.2491106047803, 1283.7881749511412, 1405.7188562287583, 7956.761297161094, 8089.676412943416, 8275.131111233355, 8276.379271554657, 8281.17188281167, 1186.0867132308074, 1189.6668932698858, 1193.886580774825, 1206.849143857018, 1212.8362671039297, 6279.403456671609, 6296.496280297565, 6305.684715764193, 6316.842078948063, 6328.6519241442165, 9991.900080999243, 10420.68737937863, 10441.321314114559, 10458.947705261426, 10569.1503986802, 8677.696280630147, 10097.798044039078, 10271.972802719669, 10313.587456501657, 10428.634997775192, 7010.439164866799, 8071.515709057476, 8186.672533098728, 8236.752897413087, 8292.37807164465, 7815.687372505036, 7909.129995700583, 7996.84006319882, 8001.239882211181, 8204.58977051157, 9130.77173070652, 9380.249580033718, 9469.431834089977, 9724.9027509724, 9733.9026609733, 8139.430239883151, 9492.57283422234, 9660.565274562521, 9707.514624268617, 9901.702948911545, 6463.64449955257, 6738.157730283715, 6934.445244380337, 6946.16646002483, 7358.006669099817, 7124.287571242834, 7788.376929845712, 7797.493162944391, 7798.37612990948, 7800.960995194988, 7001.439884809305, 7359.0, 7373.262673732584, 7495.250474952461, 7541.095068591804, 7163.355298022994, 7237.529560578546, 7329.047223861077, 7358.11702595692, 7406.07424071991, 7649.61751912391, 7682.270184332479, 7710.036245469317, 7712.035995500562, 7755.2632499912415, 6978.441724661913, 6979.406750426067, 7026.051483049927, 7028.0, 7050.224475307609, 7112.431005519649, 7113.039739635083, 7177.820554485971, 7196.784096477114, 7206.531575447579], "unit": "score", "name": "mootools.html", "value": 4876.27262439868}, {"lowerIsBetter": false, "replicates": [318.94896816509356, 323.1114435302917, 327.22937482229344, 333.63800276699794, 337.1571072319202, 6454.741810327593, 6460.741570337181, 6469.70886310116, 6500.739970401179, 6507.284198738141, 5141.948580514194, 6369.0, 6449.484041276698, 6480.611163330203, 6497.902531462032, 4575.725456472605, 4636.675432719711, 4682.719036857782, 4688.273317635755, 4799.376081109451, 4710.105080034799, 4756.7859446325, 4773.594244489223, 4775.594074503671, 4791.161546729309, 4619.884502887421, 4716.693414928036, 4717.127331443677, 4760.262159365287, 4763.809447622091, 4508.331917190628, 4580.129775342674, 4682.906341873144, 4762.833300834472, 4763.452202996647, 4040.333344998072, 4046.433499310099, 4047.98800299925, 4050.7164498485117, 4060.7563546187325, 4590.839320623762, 5976.073708575134, 6049.425304596057, 6137.877242455126, 6188.659623720693, 5524.751386187631, 5533.253010843525, 5535.501804837544, 5546.195801608785, 5548.334199896039, 6812.14848143982, 6816.625085620289, 6818.147731533559, 6821.045053692487, 6844.93155068448, 3809.904752381213, 4363.716358436692, 4523.0275490769645, 4548.977255113737, 4550.704204226715, 7111.64441777909, 7160.749373771945, 7165.820854478679, 7181.856362872765, 7183.604901730403, 4641.0, 4646.697964632288, 4648.279516674921, 4649.325847752057, 4664.603508701798, 3945.928387596535, 4731.905361892743, 4742.051589682008, 4752.429708434941, 4758.3100450434495, 5540.058190107691, 5542.362628297717, 5545.334559852843, 5549.361823390362, 5549.72251387429, 6643.800685979429, 6876.621785801829, 6883.27725588806, 6885.518013739091, 6888.173419189629, 1585.9127747973741, 1593.6334643031935, 1604.254021879808, 1608.8310727373691, 1611.2829790743008, 1006.285537268533, 1007.6825799873017, 1028.4908970059869, 1031.6131450705984, 1032.055669062814, 4998.275250088789, 5065.544101030925, 6257.9687101564205, 6317.210348706411, 6328.715207815567, 6970.372666459942, 7063.187733410621, 7092.716291348392, 7100.68046937889, 7139.750108746169, 6376.426121649074, 6385.712642931079, 6397.392247736458, 6402.135711678864, 6403.071554624554, 3756.2299728556127, 3797.0697179191275, 3797.696184305249, 3823.0633494793396, 3827.5406951165482, 6118.663473509, 6550.377714117151, 7125.859862422091, 7148.892766608505, 7442.9255707442235, 7368.078990126234, 7394.7781566553085, 7409.666565004588, 7415.962920185472, 7425.740099096506, 7451.1431185413285, 7452.217517160729, 7457.925420745832, 7476.626168691544, 7499.5875226863045, 7154.928450715426, 7184.497085204194, 7190.209077001421, 7192.460565457507, 7199.676014579251, 6790.93209067903, 7026.578405295494, 7049.859002820018, 7078.0, 7098.751543695946, 6043.425874541911, 7432.368248698921, 7442.255774422514, 7446.515976461513, 7457.776266712007, 4585.793639286173, 4587.977060114678, 4595.264757638762, 4604.263317869125, 4606.282293446749, 5839.649621022752, 7093.751718689821, 7105.573665579875, 7113.53762005468, 7120.359167674727, 6619.238787539302, 6852.6231057292325, 6908.171019477695, 6941.201761797256, 6941.34057264559, 6834.2482326943, 6881.89677154833, 6885.242623311532, 6898.689558969758, 6902.447804175755, 6738.157730283715, 6746.224184218681, 6759.695813688298, 6763.830904227237, 6776.0, 6904.13698287714, 6920.446364290945, 6932.930670693228, 6946.2011868635755, 6951.409130223786, 6443.613383197023, 6463.418292353711, 6746.291639377795, 6747.359000894907, 6769.526133170828], "unit": "score", "name": "prototype.html", "value": 5002.874787646202}, {"lowerIsBetter": false, "replicates": [677.4546490075488, 733.5195446982228, 745.7986343687209, 765.3303359560383, 779.0456690554072, 14631.487897923575, 14956.77564836527, 14977.700445991073, 14995.325210365532, 15044.94685372023, 13497.325133743298, 13504.459821607124, 13589.32053397331, 13594.048416610816, 13609.251491167981, 770.1797585571377, 895.5925054100401, 908.4640062363204, 913.55235934392, 915.8763566918448, 888.1695614600369, 904.4618452021037, 905.1582028713294, 907.1654078248027, 907.9046700096494, 952.1716106986931, 953.408886490377, 956.1442508954482, 956.9856452153223, 958.0850287974968, 944.2257348973844, 944.5182956692067, 945.0738276489011, 946.8816397950291, 946.9772645542797, 706.3783870194247, 707.0313670271761, 707.4587940225731, 708.1961973160448, 708.727140051084, 13308.0, 13417.530386436525, 13433.328333583282, 13437.66405839852, 13457.394417251247, 11296.265742726779, 11642.301461912313, 11656.533738650443, 11865.110116741278, 12080.818787718192, 10733.355998640107, 10972.341659500455, 11041.668749937515, 11168.609098681507, 11678.649640510714, 3328.2438192244404, 3516.103894814697, 3545.6986156176754, 3627.891163265106, 3643.7813731176216, 73220.63389683071, 73791.52416951685, 73821.89267160997, 73905.0, 74013.25986740172, 9081.455112693127, 9134.497602631785, 9161.954190229006, 9450.385724927857, 9462.858057129148, 19937.401877943685, 20068.598628027357, 20073.397798066082, 20102.69845952312, 20116.798832011784, 7146.535475194096, 7273.3817625502425, 7285.854282914312, 7412.518186317872, 7443.367313778282, 3958.782266975344, 4003.339448990942, 4013.538443079025, 4014.277430062617, 4016.9957510622344, 3209.951850722241, 3339.7475946520053, 3472.6700963408434, 3530.435130379127, 3539.628339024417, 606.8088552106072, 618.1191801682585, 625.4121126141413, 635.6281575278422, 635.7933671556763, 485.8178183181307, 557.5567423897929, 594.9077892926604, 616.1949959003227, 616.2050954268943, 6200.364844940882, 6693.0, 8053.436259461899, 8097.919020809834, 8180.590970451453, 578.6904006356663, 604.8487878030493, 605.6608299352289, 605.9666718330534, 623.183629445428, 2833.5891295762412, 3555.8577656893954, 3793.962060379416, 3823.5220597425323, 4018.6939244745577, 81815.59092204501, 82636.58681706553, 83260.0, 83272.58363708264, 84761.0, 55715.0, 70541.2945870545, 70756.58486830235, 70829.29170708227, 70999.2900071003, 58418.70790646019, 64511.0, 65020.67489662616, 65203.021954670716, 65423.672881635284, 8101.554414507023, 8149.755507334789, 8279.130691277329, 8358.414910956175, 8405.369597280107, 46011.0, 48057.279140812214, 48339.516604834906, 49922.75193120201, 51533.13501487328, 65486.0, 66764.6661766688, 70197.0, 70372.0, 72254.0, 11726.94136529312, 11792.23350482216, 11875.168738188244, 11946.462409191434, 12197.207181533173, 11994.520219191483, 12007.579734709243, 12054.975327096945, 12215.938920305342, 12420.689482763004, 11419.657410277705, 11565.826512602485, 11655.30068195911, 11745.706357341134, 11821.527138914347, 11465.0, 11789.351585662871, 11850.111241657083, 12043.156979011384, 12271.938640306742, 11621.825672615087, 11629.76740465169, 11667.941660291644, 12052.397380131133, 12259.632211033684, 6878.219637352192, 7909.52542847431, 9091.272698183997, 9288.72133835986, 9341.859872102059, 9273.953630231807, 9688.12806847387, 9690.854637180308, 9727.0, 9737.756556086155], "unit": "score", "name": "yui.html", "value": 6753.426641018666}], "name": "dromaeo_css", "value": 7470.695509556366}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 111.0, 110.0, 111.0, 112.0, 116.0, 111.0, 109.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [186.0, 155.0, 140.0, 162.0, 118.0, 177.0, 168.0, 120.0, 162.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 151.0}, {"lowerIsBetter": true, "replicates": [186.0, 186.0, 188.0, 186.0, 183.0, 183.0, 185.0, 182.0, 182.0, 180.0], "unit": "score", "name": "audio-dft", "value": 184.1}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 84.0, 80.0, 56.0, 58.0, 57.0, 76.0, 79.0, 56.0], "unit": "score", "name": "audio-fft", "value": 70.0}, {"lowerIsBetter": true, "replicates": [92.0, 97.0, 134.0, 79.0, 78.0, 81.0, 119.0, 80.0, 78.0, 122.0], "unit": "score", "name": "audio-oscillator", "value": 96.0}, {"lowerIsBetter": true, "replicates": [88.0, 86.0, 90.0, 88.0, 89.0, 86.0, 87.0, 88.0, 89.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.7}, {"lowerIsBetter": true, "replicates": [117.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 97.0, 95.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 97.6}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 84.0, 85.0, 84.0, 84.0, 84.0, 86.0, 85.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 84.6}, {"lowerIsBetter": true, "replicates": [52.0, 52.0, 71.0, 78.0, 78.0, 80.0, 69.0, 65.0, 55.0, 50.0], "unit": "score", "name": "json-parse-financial", "value": 65.0}, {"lowerIsBetter": true, "replicates": [65.0, 71.0, 68.0, 74.0, 73.0, 68.0, 69.0, 69.0, 69.0, 91.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.7}, {"lowerIsBetter": true, "replicates": [101.0, 98.0, 108.0, 109.0, 81.0, 80.0, 83.0, 81.0, 83.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 90.9}, {"lowerIsBetter": true, "replicates": [111.0, 137.0, 133.0, 140.0, 127.0, 121.0, 121.0, 124.0, 131.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.1}, {"lowerIsBetter": true, "replicates": [141.0, 130.0, 139.0, 139.0, 141.0, 128.0, 139.0, 139.0, 141.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.6}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 66.0, 70.0, 90.0, 91.0, 91.0, 94.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 76.9}], "name": "kraken", "value": 1451.1000000000001}]} 09:38:04 INFO - Return code: 0 09:38:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:38:04 ERROR - # TBPL SUCCESS # 09:38:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:38:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:38:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:38:04 INFO - 2016-04-07 09:38:04.249 screenresolution[2010:14948] starting screenresolution argv=screenresolution get 09:38:04 INFO - 2016-04-07 09:38:04.251 screenresolution[2010:14948] Display 0: 1600x1200x32@60 09:38:04 INFO - 2016-04-07 09:38:04.257 screenresolution[2011:14951] starting screenresolution argv=screenresolution list 09:38:04 INFO - Available Modes on Display 0 09:38:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:38:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:38:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:38:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:38:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:38:04 INFO - Intel Iris: 09:38:04 INFO - Chipset Model: Intel Iris 09:38:04 INFO - Type: GPU 09:38:04 INFO - Bus: Built-In 09:38:04 INFO - VRAM (Dynamic, Max): 1536 MB 09:38:04 INFO - Vendor: Intel (0x8086) 09:38:04 INFO - Device ID: 0x0a2e 09:38:04 INFO - Revision ID: 0x0009 09:38:04 INFO - Displays: 09:38:04 INFO - Display: 09:38:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:38:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:38:04 INFO - Display Serial Number: 1600x1200 60 09:38:04 INFO - Main Display: Yes 09:38:04 INFO - Mirror: Off 09:38:04 INFO - Online: Yes 09:38:04 INFO - Rotation: Supported 09:38:04 INFO - Return code: 0 09:38:04 INFO - Running post-action listener: _resource_record_post_action 09:38:04 INFO - Running post-run listener: _resource_record_post_run 09:38:05 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 1945600; Write bytes: 693140992; Read time: 17; Write time: 2277 09:38:05 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 390054400; Write bytes: 383903232; Read time: 30066; Write time: 685 09:38:05 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 1945600; Write bytes: 296804864; Read time: 17; Write time: 1535 09:38:05 INFO - Running post-run listener: _upload_blobber_files 09:38:05 INFO - Blob upload gear active. 09:38:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:38:05 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:38:05 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:38:05 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:38:05 INFO - (blobuploader) - INFO - Open directory for files ... 09:38:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:38:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:38:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:07 INFO - (blobuploader) - INFO - Done attempting. 09:38:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:38:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:38:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:38:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:08 INFO - (blobuploader) - INFO - Done attempting. 09:38:08 INFO - (blobuploader) - INFO - Iteration through files over. 09:38:08 INFO - Return code: 0 09:38:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:38:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:38:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1fdfeb5a68757aa1a6ba2a1130bd65402fd0d82bdadd389b47df951aa60a5a274f41f3ef9ee67d4bf1ffa53a709b2f1c7dc48ce708c6ddba81c13dcfb02fa8cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f871d2d9d44f39869adf212a7948f2077d8d4a2441eb2586c7b1701c77decb4307da7948a43b1294d9cd6877e503cbbc52464735ec6bdbf035f962757b95a0eb"} 09:38:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:38:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:38:08 INFO - Contents: 09:38:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1fdfeb5a68757aa1a6ba2a1130bd65402fd0d82bdadd389b47df951aa60a5a274f41f3ef9ee67d4bf1ffa53a709b2f1c7dc48ce708c6ddba81c13dcfb02fa8cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f871d2d9d44f39869adf212a7948f2077d8d4a2441eb2586c7b1701c77decb4307da7948a43b1294d9cd6877e503cbbc52464735ec6bdbf035f962757b95a0eb"} 09:38:08 INFO - Running post-run listener: copy_logs_to_upload_dir 09:38:08 INFO - Copying logs to upload dir... 09:38:08 INFO - mkdir: /builds/slave/test/build/upload/logs 09:38:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.738159 ========= master_lag: 6.38 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-07 09:38:14.863628) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-07 09:38:14.871245) ========= 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.VBaQavBzz6/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.bFC4Utfd8L/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1fdfeb5a68757aa1a6ba2a1130bd65402fd0d82bdadd389b47df951aa60a5a274f41f3ef9ee67d4bf1ffa53a709b2f1c7dc48ce708c6ddba81c13dcfb02fa8cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f871d2d9d44f39869adf212a7948f2077d8d4a2441eb2586c7b1701c77decb4307da7948a43b1294d9cd6877e503cbbc52464735ec6bdbf035f962757b95a0eb"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459967170/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011246 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459967170/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1fdfeb5a68757aa1a6ba2a1130bd65402fd0d82bdadd389b47df951aa60a5a274f41f3ef9ee67d4bf1ffa53a709b2f1c7dc48ce708c6ddba81c13dcfb02fa8cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f871d2d9d44f39869adf212a7948f2077d8d4a2441eb2586c7b1701c77decb4307da7948a43b1294d9cd6877e503cbbc52464735ec6bdbf035f962757b95a0eb"}' ========= master_lag: 1.19 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-07 09:38:16.077020) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 09:38:16.077382) ========= 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.VBaQavBzz6/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.bFC4Utfd8L/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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.005166 ========= master_lag: 0.16 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 09:38:16.246321) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 09:38:16.246678) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 09:38:16.288044) ========= ========= Total master_lag: 8.18 =========