builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0152 starttime: 1460030779.57 results: success (0) buildid: 20160407044324 builduid: f250fc17396e4df08b17a355b8324a3c revision: 2355485d9a8e09c7cfe47063bd192b72ec34d286 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 05:06:19.565640) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 05:06:19.566082) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 05:06:19.566370) ========= 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.GKb1OMr0Xu/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.tRbloqndPR/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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.005611 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 05:06:19.589668) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 05:06:19.589957) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 05:06:19.607472) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:06:19.607744) ========= 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.GKb1OMr0Xu/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.tRbloqndPR/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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.005429 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:06:19.655870) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 05:06:19.656185) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 05:06:19.656541) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:06:19.656821) ========= 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.GKb1OMr0Xu/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.tRbloqndPR/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 05:06:19-- 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% 163M=0s 2016-04-07 05:06:19 (163 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.214547 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:06:19.886962) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:06:19.887274) ========= 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.GKb1OMr0Xu/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.tRbloqndPR/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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.035580 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:06:19.937196) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-07 05:06:19.937544) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2355485d9a8e09c7cfe47063bd192b72ec34d286 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2355485d9a8e09c7cfe47063bd192b72ec34d286 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GKb1OMr0Xu/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.tRbloqndPR/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 05:06:20,018 truncating revision to first 12 chars 2016-04-07 05:06:20,018 Setting DEBUG logging. 2016-04-07 05:06:20,018 attempt 1/10 2016-04-07 05:06:20,018 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2355485d9a8e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-07 05:06:21,049 unpacking tar archive at: mozilla-aurora-2355485d9a8e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.284821 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-07 05:06:21.239089) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 05:06:21.239455) ========= echo 2355485d9a8e09c7cfe47063bd192b72ec34d286 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'2355485d9a8e09c7cfe47063bd192b72ec34d286'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GKb1OMr0Xu/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.tRbloqndPR/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 2355485d9a8e09c7cfe47063bd192b72ec34d286 program finished with exit code 0 elapsedTime=0.005969 script_repo_revision: '2355485d9a8e09c7cfe47063bd192b72ec34d286' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 05:06:21.289293) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 05:06:21.289601) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 05:06:21.302991) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-04-07 05:06:21.303266) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GKb1OMr0Xu/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.tRbloqndPR/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 05:06:21 INFO - MultiFileLogger online at 20160407 05:06:21 in /builds/slave/test 05:06:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:06:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:06:21 INFO - {'append_to_log': False, 05:06:21 INFO - 'base_work_dir': '/builds/slave/test', 05:06:21 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:06:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:06:21 INFO - 'branch': 'Mozilla-Aurora', 05:06:21 INFO - 'buildbot_json_path': 'buildprops.json', 05:06:21 INFO - 'config_files': ('talos/mac_config.py',), 05:06:21 INFO - 'default_actions': ('clobber', 05:06:21 INFO - 'read-buildbot-config', 05:06:21 INFO - 'download-and-extract', 05:06:21 INFO - 'populate-webroot', 05:06:21 INFO - 'create-virtualenv', 05:06:21 INFO - 'install', 05:06:21 INFO - 'run-tests'), 05:06:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:06:21 INFO - 'download_minidump_stackwalk': True, 05:06:21 INFO - 'download_symbols': 'ondemand', 05:06:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:06:21 INFO - 'tooltool.py': '/tools/tooltool.py', 05:06:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:06:21 INFO - '/tools/misc-python/virtualenv.py')}, 05:06:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:06:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:06:21 INFO - 'installer_path': 'installer.exe', 05:06:21 INFO - 'log_level': 'info', 05:06:21 INFO - 'log_name': 'talos', 05:06:21 INFO - 'log_to_console': True, 05:06:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:06:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:06:21 INFO - 'opt_config_files': (), 05:06:21 INFO - 'pip_index': False, 05:06:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:06:21 INFO - 'cmd': ('bash', 05:06:21 INFO - '-c', 05:06:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:06:21 INFO - 'enabled': True, 05:06:21 INFO - 'halt_on_failure': False, 05:06:21 INFO - 'name': 'check_screen_resolution'},), 05:06:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:06:21 INFO - 'cmd': ('bash', 05:06:21 INFO - '-c', 05:06:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:06:21 INFO - 'enabled': True, 05:06:21 INFO - 'halt_on_failure': False, 05:06:21 INFO - 'name': 'check_screen_resolution'},), 05:06:21 INFO - 'run_cmd_checks_enabled': True, 05:06:21 INFO - 'sps_profile': False, 05:06:21 INFO - 'sps_profile_interval': 0, 05:06:21 INFO - 'suite': 'dromaeojs-e10s', 05:06:21 INFO - 'system_bits': '32', 05:06:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:06:21 INFO - 'title': 't-yosemite-r7-0152', 05:06:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:06:21 INFO - 'use_talos_json': True, 05:06:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:06:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:06:21 INFO - 'work_dir': 'build'} 05:06:21 INFO - ##### 05:06:21 INFO - ##### Running clobber step. 05:06:21 INFO - ##### 05:06:21 INFO - Running pre-action listener: _resource_record_pre_action 05:06:21 INFO - Running main action method: clobber 05:06:21 INFO - rmtree: /builds/slave/test/build 05:06:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:06:23 INFO - Running post-action listener: _resource_record_post_action 05:06:23 INFO - ##### 05:06:23 INFO - ##### Running read-buildbot-config step. 05:06:23 INFO - ##### 05:06:23 INFO - Running pre-action listener: _resource_record_pre_action 05:06:23 INFO - Running main action method: read_buildbot_config 05:06:23 INFO - Using buildbot properties: 05:06:23 INFO - { 05:06:23 INFO - "project": "", 05:06:23 INFO - "product": "firefox", 05:06:23 INFO - "script_repo_revision": "production", 05:06:23 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 05:06:23 INFO - "repository": "", 05:06:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 05:06:23 INFO - "buildid": "20160407044324", 05:06:23 INFO - "stage_platform": "macosx64", 05:06:23 INFO - "basedir": "/builds/slave/test", 05:06:23 INFO - "buildnumber": 247, 05:06:23 INFO - "platform": "yosemite_r7", 05:06:23 INFO - "mozci_request": { 05:06:23 INFO - "priority": -1, 05:06:23 INFO - "type": "trigger_all_talos_jobs", 05:06:23 INFO - "times": 6 05:06:23 INFO - }, 05:06:23 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:06:23 INFO - "slavebuilddir": "test", 05:06:23 INFO - "branch": "mozilla-aurora", 05:06:23 INFO - "revision": "2355485d9a8e09c7cfe47063bd192b72ec34d286", 05:06:23 INFO - "slavename": "t-yosemite-r7-0152", 05:06:23 INFO - "builduid": "f250fc17396e4df08b17a355b8324a3c", 05:06:23 INFO - "repo_path": "releases/mozilla-aurora" 05:06:23 INFO - } 05:06:23 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.dmg. 05:06:23 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.test_packages.json. 05:06:23 INFO - Running post-action listener: _resource_record_post_action 05:06:23 INFO - ##### 05:06:23 INFO - ##### Running download-and-extract step. 05:06:23 INFO - ##### 05:06:23 INFO - Running pre-action listener: _resource_record_pre_action 05:06:23 INFO - Running main action method: download_and_extract 05:06:23 INFO - mkdir: /builds/slave/test/build/tests 05:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:23 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.test_packages.json 05:06:23 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 05:06:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 05:06:23 INFO - Downloaded 1277 bytes. 05:06:23 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 05:06:23 INFO - Using the following test package requirements: 05:06:23 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 05:06:23 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:06:23 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 05:06:23 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:06:23 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 05:06:23 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:06:23 INFO - u'jsshell-mac.zip'], 05:06:23 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:06:23 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 05:06:23 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 05:06:23 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:06:23 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 05:06:23 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:06:23 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 05:06:23 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:06:23 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 05:06:23 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 05:06:23 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:06:23 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 05:06:23 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 05:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:23 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.common.tests.zip 05:06:23 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 05:06:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:06:23 INFO - Downloaded 17904082 bytes. 05:06:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:06:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:06:26 INFO - Return code: 0 05:06:26 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 05:06:26 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')]} 05:06:26 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.common.tests.zip 05:06:26 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 05:06:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:06:26 INFO - Downloaded 17904082 bytes. 05:06:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:06:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:06:30 INFO - Return code: 0 05:06:30 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')]} 05:06:30 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.talos.tests.zip 05:06:30 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 05:06:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 05:06:30 INFO - Downloaded 10845168 bytes. 05:06:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:06:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:06:30 INFO - Return code: 0 05:06:30 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')]} 05:06:30 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.dmg 05:06:30 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 05:06:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 05:06:31 INFO - Downloaded 115185382 bytes. 05:06:31 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.dmg 05:06:31 INFO - mkdir: /builds/slave/test/properties 05:06:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:06:31 INFO - Writing to file /builds/slave/test/properties/build_url 05:06:31 INFO - Contents: 05:06:31 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.dmg 05:06:32 INFO - Running post-action listener: _resource_record_post_action 05:06:32 INFO - Running post-action listener: set_extra_try_arguments 05:06:32 INFO - ##### 05:06:32 INFO - ##### Running populate-webroot step. 05:06:32 INFO - ##### 05:06:32 INFO - Running pre-action listener: _resource_record_pre_action 05:06:32 INFO - Running main action method: populate_webroot 05:06:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:06:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:06:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:06:32 INFO - '--tppagecycles', 05:06:32 INFO - '7'], 05:06:32 INFO - 'tests': ['tsvgm']}}, 05:06:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:06:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:06:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:06:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:06:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:06:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:06:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:06:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:32 INFO - 'talos_options': ['--e10s'], 05:06:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:06:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:32 INFO - 'tests': ['damp', 'tps']}, 05:06:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:32 INFO - 'talos_options': ['--e10s'], 05:06:32 INFO - 'tests': ['damp', 'tps']}, 05:06:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:06:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:06:32 INFO - 'other': {'tests': ['a11yr', 05:06:32 INFO - 'ts_paint', 05:06:32 INFO - 'tpaint', 05:06:32 INFO - 'sessionrestore', 05:06:32 INFO - 'sessionrestore_no_auto_restore', 05:06:32 INFO - 'tabpaint']}, 05:06:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:06:32 INFO - 'tests': ['a11yr', 05:06:32 INFO - 'ts_paint', 05:06:32 INFO - 'tpaint', 05:06:32 INFO - 'sessionrestore', 05:06:32 INFO - 'sessionrestore_no_auto_restore', 05:06:32 INFO - 'tabpaint']}, 05:06:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:06:32 INFO - 'tests': ['a11yr', 05:06:32 INFO - 'ts_paint', 05:06:32 INFO - 'tpaint', 05:06:32 INFO - 'sessionrestore', 05:06:32 INFO - 'sessionrestore_no_auto_restore', 05:06:32 INFO - 'tabpaint']}, 05:06:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:06:32 INFO - 'tests': ['a11yr', 05:06:32 INFO - 'ts_paint', 05:06:32 INFO - 'tpaint', 05:06:32 INFO - 'sessionrestore', 05:06:32 INFO - 'sessionrestore_no_auto_restore', 05:06:32 INFO - 'tabpaint']}, 05:06:32 INFO - 'other_l64': {'tests': ['a11yr', 05:06:32 INFO - 'ts_paint', 05:06:32 INFO - 'tpaint', 05:06:32 INFO - 'sessionrestore', 05:06:32 INFO - 'sessionrestore_no_auto_restore', 05:06:32 INFO - 'tabpaint']}, 05:06:32 INFO - 'other_nol64': {'tests': ['a11yr', 05:06:32 INFO - 'ts_paint', 05:06:32 INFO - 'tpaint', 05:06:32 INFO - 'sessionrestore', 05:06:32 INFO - 'sessionrestore_no_auto_restore', 05:06:32 INFO - 'tabpaint']}, 05:06:32 INFO - 'svgr': {'tests': ['tsvgx', 05:06:32 INFO - 'tsvgr_opacity', 05:06:32 INFO - 'tart', 05:06:32 INFO - 'tscrollx', 05:06:32 INFO - 'cart']}, 05:06:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:06:32 INFO - 'tests': ['tsvgx', 05:06:32 INFO - 'tsvgr_opacity', 05:06:32 INFO - 'tart', 05:06:32 INFO - 'tscrollx', 05:06:32 INFO - 'cart']}, 05:06:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:32 INFO - 'tests': ['tp5o']}, 05:06:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:32 INFO - 'talos_options': ['--e10s'], 05:06:32 INFO - 'tests': ['tp5o']}, 05:06:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:32 INFO - 'talos_options': ['--xperf_path', 05:06:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:06:32 INFO - 'tests': ['tp5n']}, 05:06:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:32 INFO - 'talos_options': ['--e10s', 05:06:32 INFO - '--xperf_path', 05:06:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:06:32 INFO - 'tests': ['tp5n']}}, 05:06:32 INFO - 'talos.zip': {'path': '', 05:06:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:06:32 INFO - Running post-action listener: _resource_record_post_action 05:06:32 INFO - ##### 05:06:32 INFO - ##### Running create-virtualenv step. 05:06:32 INFO - ##### 05:06:32 INFO - Running pre-action listener: _resource_record_pre_action 05:06:32 INFO - Running main action method: create_virtualenv 05:06:32 INFO - Creating virtualenv /builds/slave/test/build/venv 05:06:32 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 05:06:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:06:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:06:32 INFO - Using real prefix '/tools/python27' 05:06:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:06:33 INFO - Installing distribute.............................................................................................................................................................................................done. 05:06:35 INFO - Installing pip.................done. 05:06:35 INFO - Return code: 0 05:06:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:35 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 0x101a99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f835ac6b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10193dd30>, '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 0x1017a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101934b20>, '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.GKb1OMr0Xu/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.tRbloqndPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 05:06:35 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 05:06:35 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 05:06:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GKb1OMr0Xu/Render', 05:06:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:35 INFO - 'HOME': '/Users/cltbld', 05:06:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:35 INFO - 'LOGNAME': 'cltbld', 05:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:35 INFO - 'MOZ_NO_REMOTE': '1', 05:06:35 INFO - 'NO_EM_RESTART': '1', 05:06:35 INFO - 'PAGER': '/bin/cat', 05:06:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:35 INFO - 'PWD': '/builds/slave/test', 05:06:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:35 INFO - 'SHELL': '/bin/bash', 05:06:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tRbloqndPR/Listeners', 05:06:35 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 05:06:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:35 INFO - 'USER': 'cltbld', 05:06:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:35 INFO - 'XPC_FLAGS': '0x0', 05:06:35 INFO - 'XPC_SERVICE_NAME': '0', 05:06:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:36 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 05:06:36 INFO - Cleaning up... 05:06:36 INFO - Return code: 0 05:06:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:06: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')]} 05:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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')]} 05:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:36 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 0x101a99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f835ac6b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10193dd30>, '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 0x1017a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101934b20>, '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.GKb1OMr0Xu/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.tRbloqndPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 05:06:36 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 05:06:36 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 05:06:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GKb1OMr0Xu/Render', 05:06:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:36 INFO - 'HOME': '/Users/cltbld', 05:06:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:36 INFO - 'LOGNAME': 'cltbld', 05:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:36 INFO - 'MOZ_NO_REMOTE': '1', 05:06:36 INFO - 'NO_EM_RESTART': '1', 05:06:36 INFO - 'PAGER': '/bin/cat', 05:06:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:36 INFO - 'PWD': '/builds/slave/test', 05:06:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:36 INFO - 'SHELL': '/bin/bash', 05:06:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tRbloqndPR/Listeners', 05:06:36 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 05:06:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:36 INFO - 'USER': 'cltbld', 05:06:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:36 INFO - 'XPC_FLAGS': '0x0', 05:06:36 INFO - 'XPC_SERVICE_NAME': '0', 05:06:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:36 INFO - Downloading/unpacking psutil>=0.7.1 05:06:36 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 05:06:36 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 05:06:36 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 05:06:36 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 05:06:36 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 05:06:36 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 05:06:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:06:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:06:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:06:39 INFO - Installing collected packages: psutil 05:06:39 INFO - Running setup.py install for psutil 05:06:39 INFO - building 'psutil._psutil_osx' extension 05:06:39 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 05:06:40 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 05:06:40 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 05:06:40 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 05:06:40 INFO - building 'psutil._psutil_posix' extension 05:06:40 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 05:06:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:06:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:06:40 INFO - ^ 05:06:40 INFO - 1 warning generated. 05:06:40 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 05:06:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:06:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:06:41 INFO - Successfully installed psutil 05:06:41 INFO - Cleaning up... 05:06:41 INFO - Return code: 0 05:06:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:06: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')]} 05:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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')]} 05:06:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:41 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 0x101a99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f835ac6b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10193dd30>, '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 0x1017a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101934b20>, '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.GKb1OMr0Xu/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.tRbloqndPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 05:06:41 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 05:06:41 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 05:06:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GKb1OMr0Xu/Render', 05:06:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:41 INFO - 'HOME': '/Users/cltbld', 05:06:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:41 INFO - 'LOGNAME': 'cltbld', 05:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:41 INFO - 'MOZ_NO_REMOTE': '1', 05:06:41 INFO - 'NO_EM_RESTART': '1', 05:06:41 INFO - 'PAGER': '/bin/cat', 05:06:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:41 INFO - 'PWD': '/builds/slave/test', 05:06:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:41 INFO - 'SHELL': '/bin/bash', 05:06:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tRbloqndPR/Listeners', 05:06:41 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 05:06:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:41 INFO - 'USER': 'cltbld', 05:06:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:41 INFO - 'XPC_FLAGS': '0x0', 05:06:41 INFO - 'XPC_SERVICE_NAME': '0', 05:06:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:06:41 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 05:06:41 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 05:06:41 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 05:06:41 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 05:06:41 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 05:06:41 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 05:06:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:06:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:06:43 INFO - Installing collected packages: mozsystemmonitor 05:06:43 INFO - Running setup.py install for mozsystemmonitor 05:06:43 INFO - Successfully installed mozsystemmonitor 05:06:43 INFO - Cleaning up... 05:06:44 INFO - Return code: 0 05:06:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:44 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 0x101a99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f835ac6b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10193dd30>, '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 0x1017a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101934b20>, '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.GKb1OMr0Xu/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.tRbloqndPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 05:06:44 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 05:06:44 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 05:06:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GKb1OMr0Xu/Render', 05:06:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:44 INFO - 'HOME': '/Users/cltbld', 05:06:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:44 INFO - 'LOGNAME': 'cltbld', 05:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:44 INFO - 'MOZ_NO_REMOTE': '1', 05:06:44 INFO - 'NO_EM_RESTART': '1', 05:06:44 INFO - 'PAGER': '/bin/cat', 05:06:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:44 INFO - 'PWD': '/builds/slave/test', 05:06:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:44 INFO - 'SHELL': '/bin/bash', 05:06:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tRbloqndPR/Listeners', 05:06:44 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 05:06:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:44 INFO - 'USER': 'cltbld', 05:06:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:44 INFO - 'XPC_FLAGS': '0x0', 05:06:44 INFO - 'XPC_SERVICE_NAME': '0', 05:06:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:44 INFO - Downloading/unpacking blobuploader==1.2.4 05:06:44 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 05:06:44 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 05:06:44 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 05:06:44 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 05:06:44 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 05:06:44 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 05:06:46 INFO - Downloading blobuploader-1.2.4.tar.gz 05:06:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:06:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:06:46 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 05:06:46 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 05:06:46 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 05:06:46 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 05:06:46 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 05:06:46 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 05:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:06:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06:47 INFO - Downloading docopt-0.6.1.tar.gz 05:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:06:47 INFO - Installing collected packages: blobuploader, requests, docopt 05:06:47 INFO - Running setup.py install for blobuploader 05:06:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:06:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:06:48 INFO - Running setup.py install for requests 05:06:48 INFO - Running setup.py install for docopt 05:06:48 INFO - Successfully installed blobuploader requests docopt 05:06:48 INFO - Cleaning up... 05:06:48 INFO - Return code: 0 05:06:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:48 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 0x101a99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f835ac6b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10193dd30>, '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 0x1017a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101934b20>, '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.GKb1OMr0Xu/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.tRbloqndPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 05:06:48 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 05:06:48 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 05:06:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GKb1OMr0Xu/Render', 05:06:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:48 INFO - 'HOME': '/Users/cltbld', 05:06:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:48 INFO - 'LOGNAME': 'cltbld', 05:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:48 INFO - 'MOZ_NO_REMOTE': '1', 05:06:48 INFO - 'NO_EM_RESTART': '1', 05:06:48 INFO - 'PAGER': '/bin/cat', 05:06:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:48 INFO - 'PWD': '/builds/slave/test', 05:06:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:48 INFO - 'SHELL': '/bin/bash', 05:06:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tRbloqndPR/Listeners', 05:06:48 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 05:06:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:48 INFO - 'USER': 'cltbld', 05:06:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:48 INFO - 'XPC_FLAGS': '0x0', 05:06:48 INFO - 'XPC_SERVICE_NAME': '0', 05:06:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:06:49 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-xg1Zjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:06:49 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-ZctipJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:06:49 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-Grg3IU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:06:49 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-P4GTLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:06:49 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-sns7Ka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:06:49 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-OSa5Xq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:06:49 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-5TcKI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:06:49 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-4tOJpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:06:49 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-UDIUR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:06:50 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-xIPoS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:06:50 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-ZBFf3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:06:50 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-cs0bCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:06:50 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-yrRRik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:06:50 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-5QFi3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:50 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-3ihRMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:06:50 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-rezYNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:06:50 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-czzphE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:06:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:06:50 INFO - Running setup.py install for manifestparser 05:06:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:06:50 INFO - Running setup.py install for mozcrash 05:06:51 INFO - Running setup.py install for mozdebug 05:06:51 INFO - Running setup.py install for mozdevice 05:06:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:06:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:06:51 INFO - Running setup.py install for mozfile 05:06:51 INFO - Running setup.py install for mozhttpd 05:06:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:06:51 INFO - Running setup.py install for mozinfo 05:06:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:06:51 INFO - Running setup.py install for mozInstall 05:06:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:06:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:06:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:06:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:06:51 INFO - Running setup.py install for mozleak 05:06:52 INFO - Running setup.py install for mozlog 05:06:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:06:52 INFO - Running setup.py install for moznetwork 05:06:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:06:52 INFO - Running setup.py install for mozprocess 05:06:52 INFO - Running setup.py install for mozprofile 05:06:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:06:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:06:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:06:52 INFO - Running setup.py install for mozrunner 05:06:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:06:52 INFO - Running setup.py install for mozscreenshot 05:06:53 INFO - Running setup.py install for moztest 05:06:53 INFO - Running setup.py install for mozversion 05:06:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:06:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:06:53 INFO - Cleaning up... 05:06:53 INFO - Return code: 0 05:06:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:53 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 0x101a99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f835ac6b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10193dd30>, '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 0x1017a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101934b20>, '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.GKb1OMr0Xu/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.tRbloqndPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 05:06:53 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 05:06:53 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 05:06:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GKb1OMr0Xu/Render', 05:06:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:53 INFO - 'HOME': '/Users/cltbld', 05:06:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:53 INFO - 'LOGNAME': 'cltbld', 05:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:53 INFO - 'MOZ_NO_REMOTE': '1', 05:06:53 INFO - 'NO_EM_RESTART': '1', 05:06:53 INFO - 'PAGER': '/bin/cat', 05:06:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:53 INFO - 'PWD': '/builds/slave/test', 05:06:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:53 INFO - 'SHELL': '/bin/bash', 05:06:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tRbloqndPR/Listeners', 05:06:53 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 05:06:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:53 INFO - 'USER': 'cltbld', 05:06:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:53 INFO - 'XPC_FLAGS': '0x0', 05:06:53 INFO - 'XPC_SERVICE_NAME': '0', 05:06:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:06:53 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-n856Iz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:06:53 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)) 05:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:06:53 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-YjVJ7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:06:53 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)) 05:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:06:53 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-CiZ6wv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:06:53 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)) 05:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:06:54 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-9Jjcfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:06:54 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)) 05:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:06:54 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-4yXKIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:06:54 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)) 05:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:06:54 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-wt1yu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:06:54 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)) 05:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:06:54 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-2IEl1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:06:54 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)) 05:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:06:54 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-MvNWT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:06:54 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)) 05:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:06:54 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-RZUjiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:06:54 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)) 05:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:06:54 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-NFyGb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:06:54 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)) 05:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:06:54 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-XPGh4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:06:54 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)) 05:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:06:54 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-nyzTQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:06:54 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)) 05:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:06:54 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-qbUhf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:06:55 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)) 05:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:06:55 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-NvsgLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:06:55 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)) 05:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:55 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-SwczKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:55 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)) 05:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:06:55 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-MYjlRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:06:55 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)) 05:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:06:55 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-BGZ4wM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:06:55 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)) 05:06:55 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)) 05:06:55 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)) 05:06:55 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)) 05:06:55 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)) 05:06:55 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)) 05:06:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:57 INFO - Downloading blessings-1.6.tar.gz 05:06:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:06:57 INFO - Installing collected packages: blessings 05:06:57 INFO - Running setup.py install for blessings 05:06:58 INFO - Successfully installed blessings 05:06:58 INFO - Cleaning up... 05:06:58 INFO - Return code: 0 05:06:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:06:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:06:58 INFO - Reading from file tmpfile_stdout 05:06:58 INFO - Current package versions: 05:06:58 INFO - blessings == 1.6 05:06:58 INFO - blobuploader == 1.2.4 05:06:58 INFO - docopt == 0.6.1 05:06:58 INFO - manifestparser == 1.1 05:06:58 INFO - mozInstall == 1.12 05:06:58 INFO - mozcrash == 0.17 05:06:58 INFO - mozdebug == 0.1 05:06:58 INFO - mozdevice == 0.48 05:06:58 INFO - mozfile == 1.2 05:06:58 INFO - mozhttpd == 0.7 05:06:58 INFO - mozinfo == 0.9 05:06:58 INFO - mozleak == 0.1 05:06:58 INFO - mozlog == 3.1 05:06:58 INFO - moznetwork == 0.27 05:06:58 INFO - mozprocess == 0.22 05:06:58 INFO - mozprofile == 0.28 05:06:58 INFO - mozrunner == 6.11 05:06:58 INFO - mozscreenshot == 0.1 05:06:58 INFO - mozsystemmonitor == 0.0 05:06:58 INFO - moztest == 0.7 05:06:58 INFO - mozversion == 1.4 05:06:58 INFO - psutil == 3.1.1 05:06:58 INFO - requests == 1.2.3 05:06:58 INFO - wsgiref == 0.1.2 05:06:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:58 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 0x101a99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f835ac6b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10193dd30>, '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 0x1017a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101934b20>, '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.GKb1OMr0Xu/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.tRbloqndPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 05:06:58 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 05:06:58 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 05:06:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GKb1OMr0Xu/Render', 05:06:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:58 INFO - 'HOME': '/Users/cltbld', 05:06:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:58 INFO - 'LOGNAME': 'cltbld', 05:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:58 INFO - 'MOZ_NO_REMOTE': '1', 05:06:58 INFO - 'NO_EM_RESTART': '1', 05:06:58 INFO - 'PAGER': '/bin/cat', 05:06:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:58 INFO - 'PWD': '/builds/slave/test', 05:06:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:58 INFO - 'SHELL': '/bin/bash', 05:06:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tRbloqndPR/Listeners', 05:06:58 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 05:06:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:58 INFO - 'USER': 'cltbld', 05:06:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:58 INFO - 'XPC_FLAGS': '0x0', 05:06:58 INFO - 'XPC_SERVICE_NAME': '0', 05:06:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:58 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)) 05:06:58 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)) 05:06:58 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)) 05:06:58 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)) 05:06:58 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)) 05:06:58 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)) 05:06:58 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)) 05:06:58 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)) 05:06:58 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)) 05:06:58 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)) 05:06:58 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)) 05:06:58 INFO - Cleaning up... 05:06:58 INFO - Return code: 0 05:06:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101a99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f835ac6b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10193dd30>, '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 0x1017a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101934b20>, '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.GKb1OMr0Xu/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.tRbloqndPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 05:06:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:06:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GKb1OMr0Xu/Render', 05:06:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:58 INFO - 'HOME': '/Users/cltbld', 05:06:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:58 INFO - 'LOGNAME': 'cltbld', 05:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:58 INFO - 'MOZ_NO_REMOTE': '1', 05:06:58 INFO - 'NO_EM_RESTART': '1', 05:06:58 INFO - 'PAGER': '/bin/cat', 05:06:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:58 INFO - 'PWD': '/builds/slave/test', 05:06:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:58 INFO - 'SHELL': '/bin/bash', 05:06:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tRbloqndPR/Listeners', 05:06:58 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 05:06:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:58 INFO - 'USER': 'cltbld', 05:06:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:58 INFO - 'XPC_FLAGS': '0x0', 05:06:58 INFO - 'XPC_SERVICE_NAME': '0', 05:06:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:59 INFO - Downloading/unpacking jsonschema 05:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:07:01 INFO - Downloading/unpacking functools32 (from jsonschema) 05:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:01 INFO - Downloading functools32-3.2.3-2.tar.gz 05:07:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:07:01 INFO - warning: no files found matching '*.txt' 05:07:01 INFO - no previously-included directories found matching 'build' 05:07:01 INFO - no previously-included directories found matching 'dist' 05:07:01 INFO - no previously-included directories found matching '.git*' 05:07:01 INFO - Installing collected packages: jsonschema, functools32 05:07:02 INFO - Running setup.py install for functools32 05:07:02 INFO - warning: no files found matching '*.txt' 05:07:02 INFO - no previously-included directories found matching 'build' 05:07:02 INFO - no previously-included directories found matching 'dist' 05:07:02 INFO - no previously-included directories found matching '.git*' 05:07:02 INFO - Successfully installed jsonschema functools32 05:07:02 INFO - Cleaning up... 05:07:02 INFO - Return code: 0 05:07:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:02 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 0x101a99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101aa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f835ac6b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10193dd30>, '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 0x1017a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101934b20>, '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.GKb1OMr0Xu/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.tRbloqndPR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 05:07:02 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 05:07:02 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 05:07:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GKb1OMr0Xu/Render', 05:07:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:02 INFO - 'HOME': '/Users/cltbld', 05:07:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:02 INFO - 'LOGNAME': 'cltbld', 05:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:02 INFO - 'MOZ_NO_REMOTE': '1', 05:07:02 INFO - 'NO_EM_RESTART': '1', 05:07:02 INFO - 'PAGER': '/bin/cat', 05:07:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:02 INFO - 'PWD': '/builds/slave/test', 05:07:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:02 INFO - 'SHELL': '/bin/bash', 05:07:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tRbloqndPR/Listeners', 05:07:02 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 05:07:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:02 INFO - 'USER': 'cltbld', 05:07:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:02 INFO - 'XPC_FLAGS': '0x0', 05:07:02 INFO - 'XPC_SERVICE_NAME': '0', 05:07:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:02 INFO - Downloading/unpacking flake8 05:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:07:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:07:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:07:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:07:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:07:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:07:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:07:06 INFO - no previously-included directories found matching 'docs/_build' 05:07:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:07:06 INFO - Running setup.py install for pep8 05:07:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:07:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:07:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:07:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:07:06 INFO - no previously-included directories found matching 'docs/_build' 05:07:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:07:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:07:06 INFO - Cleaning up... 05:07:06 INFO - Return code: 0 05:07:06 INFO - Running post-action listener: _resource_record_post_action 05:07:06 INFO - Running post-action listener: _start_resource_monitoring 05:07:06 INFO - Starting resource monitoring. 05:07:06 INFO - ##### 05:07:06 INFO - ##### Running install step. 05:07:06 INFO - ##### 05:07:06 INFO - Running pre-action listener: _resource_record_pre_action 05:07:06 INFO - Running main action method: install 05:07:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:07:06 INFO - Reading from file tmpfile_stdout 05:07:06 INFO - Detecting whether we're running mozinstall >=1.0... 05:07:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:07:06 INFO - Reading from file tmpfile_stdout 05:07:06 INFO - Output received: 05:07:06 INFO - Usage: mozinstall [options] installer 05:07:06 INFO - Options: 05:07:06 INFO - -h, --help show this help message and exit 05:07:06 INFO - -d DEST, --destination=DEST 05:07:06 INFO - Directory to install application into. [default: 05:07:06 INFO - "/builds/slave/test"] 05:07:06 INFO - --app=APP Application being installed. [default: firefox] 05:07:06 INFO - mkdir: /builds/slave/test/build/application 05:07:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 05:07:38 INFO - Reading from file tmpfile_stdout 05:07:38 INFO - Output received: 05:07:38 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 05:07:38 INFO - Running post-action listener: _resource_record_post_action 05:07:38 INFO - ##### 05:07:38 INFO - ##### Running run-tests step. 05:07:38 INFO - ##### 05:07:38 INFO - Running pre-action listener: _resource_record_pre_action 05:07:38 INFO - Running main action method: run_tests 05:07:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:07:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:07:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:07:38 INFO - 2016-04-07 05:07:38.855 screenresolution[1641:7430] starting screenresolution argv=screenresolution get 05:07:38 INFO - 2016-04-07 05:07:38.858 screenresolution[1641:7430] Display 0: 1600x1200x32@60 05:07:38 INFO - 2016-04-07 05:07:38.863 screenresolution[1642:7432] starting screenresolution argv=screenresolution list 05:07:38 INFO - Available Modes on Display 0 05:07:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:07:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:07:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:07:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:07:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:07:39 INFO - Intel Iris: 05:07:39 INFO - Chipset Model: Intel Iris 05:07:39 INFO - Type: GPU 05:07:39 INFO - Bus: Built-In 05:07:39 INFO - VRAM (Dynamic, Max): 1536 MB 05:07:39 INFO - Vendor: Intel (0x8086) 05:07:39 INFO - Device ID: 0x0a2e 05:07:39 INFO - Revision ID: 0x0009 05:07:39 INFO - Displays: 05:07:39 INFO - Display: 05:07:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:07:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:07:39 INFO - Display Serial Number: 1600x1200 60 05:07:39 INFO - Main Display: Yes 05:07:39 INFO - Mirror: Off 05:07:39 INFO - Online: Yes 05:07:39 INFO - Rotation: Supported 05:07:39 INFO - Return code: 0 05:07:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:07:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:07:39 INFO - Python 2.7.3 05:07:39 INFO - Return code: 0 05:07:39 INFO - grabbing minidump binary from tooltool 05:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:39 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 0x10193dd30>, '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 0x1017a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101934b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:07:39 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 05:07:39 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 05:07:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:07:39 INFO - Return code: 0 05:07:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:07:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:07:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:07:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:07:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:07:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:07:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:07:40 INFO - Return code: 0 05:07:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0152', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:07:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0152 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:07:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GKb1OMr0Xu/Render', 05:07:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:40 INFO - 'HOME': '/Users/cltbld', 05:07:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:40 INFO - 'LOGNAME': 'cltbld', 05:07:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:07:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:07:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:40 INFO - 'MOZ_NO_REMOTE': '1', 05:07:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:07:40 INFO - 'NO_EM_RESTART': '1', 05:07:40 INFO - 'PAGER': '/bin/cat', 05:07:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:40 INFO - 'PWD': '/builds/slave/test', 05:07:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:07:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:40 INFO - 'SHELL': '/bin/bash', 05:07:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tRbloqndPR/Listeners', 05:07:40 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 05:07:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:40 INFO - 'USER': 'cltbld', 05:07:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:40 INFO - 'XPC_FLAGS': '0x0', 05:07:40 INFO - 'XPC_SERVICE_NAME': '0', 05:07:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0152', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:07:40 INFO - mozversion application_buildid: 20160406205952 05:07:40 INFO - mozversion application_changeset: 2355485d9a8e09c7cfe47063bd192b72ec34d286 05:07:40 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:07:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:07:40 INFO - mozversion application_name: Firefox 05:07:40 INFO - mozversion application_remotingname: firefox-dev 05:07:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:07:40 INFO - mozversion application_vendor: Mozilla 05:07:40 INFO - mozversion application_version: 47.0a2 05:07:40 INFO - mozversion platform_buildid: 20160406205952 05:07:40 INFO - mozversion platform_changeset: 2355485d9a8e09c7cfe47063bd192b72ec34d286 05:07:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:07:40 INFO - mozversion platform_version: 47.0a2 05:07:40 INFO - using testdate: 1460030860 05:07:40 INFO - actual date: 1460030860 05:07:40 INFO - starting webserver on 'localhost:49272' 05:07:40 INFO - SUITE-START | Running 2 tests 05:07:40 INFO - TEST-START | dromaeo_css 05:07:40 INFO - operating with platform_type : mac_ 05:07:40 INFO - Initialising browser for dromaeo_css test... 05:07:40 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmp0EIQVS/profile http://localhost:49272/getInfo.html) 05:07:43 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 05:07:43 INFO - PROCESS | 1660 | colorDepth:24 05:07:43 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 05:07:43 INFO - PROCESS | 1660 | __metrics 05:07:43 ERROR - PROCESS | 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 05:07:43 INFO - TEST-INFO | 1660: exit 0 05:07:43 INFO - Browser initialized. 05:07:43 INFO - Running cycle 1/1 for dromaeo_css test... 05:07:43 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmp0EIQVS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:07:55 INFO - PROCESS | 1663 | RSS: Main: 217763840 05:07:55 INFO - PROCESS | 1663 | 05:08:45 INFO - PROCESS | 1663 | 1460030925521 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] 05:10:56 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 05:10:57 INFO - PROCESS | 1663 | RSS: Main: 228478976 05:10:57 INFO - PROCESS | 1663 | 05:13:59 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 05:14:00 INFO - PROCESS | 1663 | RSS: Main: 240119808 05:14:00 INFO - PROCESS | 1663 | 05:17:01 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 05:17:02 INFO - PROCESS | 1663 | RSS: Main: 243097600 05:17:02 INFO - PROCESS | 1663 | 05:20:03 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 05:20:04 INFO - PROCESS | 1663 | RSS: Main: 243806208 05:20:04 INFO - PROCESS | 1663 | 05:23:07 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 05:23:07 INFO - PROCESS | 1663 | RSS: Main: 246562816 05:23:07 INFO - PROCESS | 1663 | 05:26:09 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 05:26:10 INFO - PROCESS | 1663 | RSS: Main: 248156160 05:26:10 INFO - PROCESS | 1663 | 05:26:10 INFO - PROCESS | 1663 | __start_tp_report 05:26:10 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 05:26:10 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 05:26:10 INFO - PROCESS | 1663 | |i|pagename|runs| 05:26:10 INFO - PROCESS | 1663 | |0;dojo.html;3165.98417007915;3535.9823200883993;3543.4330507118866;3571.5535558055244;3598.0645032291595;5763.0779075347955;5766.682832444214;5784.826455206346;5792.044312688412;5818.214541036964;5076;5393.217983392406;5774.133879918015;5817.621854579449;5874.412558744123;4540.023894862604;4974.751262436882;5244.846133850547;5259.631825772198;5296.788128474856;5160.380754309488;5273.762680679379;5297.311349524556;5342.198670199462;5398.406175320712;4400.383946247512;5298.867528311804;5299.417064122943;5305.257263983045;5305.840824775243;5242.8689282767855;5247.449017853109;5283.049051170788;5298.549623282006;5382.165764306539;4677.947461821063;5079.517445842639;5162.664426812245;5228.398734145584;5339.5728341732565;5759.424057594207;5793.159991801207;5802.796902108406;5812.5640576956475;5853.151293062525;5897.675627840467;6115.544587952024;6299.244090709099;6331.2085989251345;6371.426571608577;5961.850953726148;6297.0554416837385;6318.083877837687;6325.96837015812;6326.5255105867245;4851.296561998526;5936.97031514844;5955.672438015908;6012.518998480111;6016.669083200466;6255.96872015637;6262.530310226751;6293.590916590407;6426.775062872777;6459.450946669492;6154.630722156685;6155.692215389213;6177.81466556004;6184.288806787187;6216.471599913967;6279.560430769802;6298.433141017331;6305.274893387227;6308.716107775161;6315.621062736251;6172.69136543171;6216.751329946842;6236.719347629368;6290.056491526308;6341.3341599132345;6266;6306.432421082125;6311.147995020705;6311.305756366796;6347.206599175103;4953.851384458472;4973.154563724175;5004.374453193351;5015.523525265094;5049.9495005049475;4363;4372.016296333363;4420.115976804652;4460.397846290774;4512.458504979423;6011.158437818709;6031.125486804476;6054.152418661391;6069.332373438918;6071.696415179224;6225.8132256032395;6310.274318453345;6337.746490140343;6351.96824015877;6368.77709280173;5760.107183386582;5924.052151655715;5978.940210597925;6017.548683848641;6063.636181829104;5455.099908515051;5459.672419654833;5461.1808228766;5495.230667706524;5498.5876059294915;6352.777652782131;6540.051692504655;6541.247756508063;6543.607383557001;6555.311692272338;6225.190725205875;6267.341929097379;6281.96859015702;6313.2424109107205;6313.368663133833;6465.191851018622;6484.383983521558;6485.77299794505;6487.18910136233;6502.902456463063;6132.662703551169;6189.6286222826775;6315.115883776183;6326.620402775849;6332.905006424815;6273.090401891609;6290.842728931813;6311.368863113652;6314.84212894663;6317.905231421624;6215.595986260879;6229.345918678655;6259.155014073224;6266.749330026748;6305.432511074026;6124.448799608057;6132.04958718918;6155.907661385172;6205.379462053939;6294.0558916162945;6004.759809607567;6075.1798507200965;6128.050152226234;6131.896258673303;6139.815805525842;6244.438000579969;6251.151672103534;6270.15352927349;6291.231857982473;6297.4017468340435;4425.800838962319;4965.329680493087;5243.8164664236565;5772.6536407815665;6186.5360097993735 05:26:10 INFO - PROCESS | 1663 | |1;ext.html;519.6154845414393;525.6845892464522;582.6009183709159;602.9577929544928;650.385385810409;31732.841335793288;39104.21791564167;40100.398494022615;40243.396349054754;40288.39567406488;41465.58534414655;41793.16413671725;41944.58055419445;41971;42318.78840605792;9511.28665350098;9693.127618514332;9746.902530974707;9756.560954757017;9771.364861283993;9610.519474026305;9793.461359625218;9795.510224488782;9875.802483950316;9904.90095099047;9856.35933664313;9873.555689993931;9946.353487023356;9952.154066904322;9961.501924903761;9833.704988850346;9886.653967111153;9919.553620087114;9922.702318930444;9923.65267215644;7501.924980750177;9722.562484688206;9737.610495580167;9829;9887.505624718735;40667.186656267004;40893.79553102245;41088.79455602703;41216;41500.37749433761;3221.983890080558;3294.5387645729616;3294.6540613235743;3335.69978701918;3356;27964;29093;29989.700102998908;30737.231569210726;31101.688983110333;2797.230761540572;2818.4504021715775;2828.0808737160505;2854.942901141986;2897.971220216814;347183;348156.25921870227;348351;350909;351283;47998.5200148001;48690.78273043202;48797.51202488001;73950.89073663899;74247.25752742511;47395;48446;48454;48702.51297487051;48846;17234.65530689404;17423.65152696939;17590.768646194898;17598.29606815713;17620.9118954407;13891.305434728223;13894.166350019032;13954.09298395601;13975.161490310615;14051.718965620836;15861.920690396704;15897.443589474544;15976.641985431135;15994.440194593133;15994.680106397807;5503.944960550343;5580.693061881554;6579.30917253691;6630.701618427182;6675.632840193836;985.4875464758286;1000.1898462245605;1088.8911108889206;1118.3234143343323;1140.5779861451151;30853.765849366224;31621;31676.524852127237;31844.840775796438;32276.83861580677;907.9364444488822;1045;1123.2025262063862;1211.3156066822216;1246.4951694563715;12286.815697764541;13214.801777973338;15459.917805753714;15483.922580387027;15913.761293580606;619423;635074;637818;641247;643809;60704.69647651822;66733.33266667368;66875.99686004713;67091.6581668364;67176;1510.8262549806914;1514.295852428626;1527.7020980908617;1549.5738671865101;1555;31320.37359252848;31545.211369715023;31552.84223578959;31615.446018758365;32104.67895321017;55684.72157639348;55875.88248234931;56239;56347.71826140843;56459.71770141123;473256;483370;483902;484241;485799;34143.82928085344;34423.65576344305;35041.64958350384;35673.92978210658;36203.63796362003;46988.7650561745;47104.7644761774;47275.29087063628;48046.279305809745;48114.518854811;38458.23083538258;38728.419073713354;39665.60334396619;39925.60074399219;40327.798361008005;38113.80943095267;38542;39217;39357.80321098376;40138.19723605453;32925.83537082299;33381.49927751037;38501.6149838498;38827.80586097051;40085;26616.334591635365;31188.532172016985;31911.68088319087;33015.33969320648;33357.499637504974;25654.486910261316;25790;25974.09090681817;25979.74020259773;26017.495626093478 05:26:10 INFO - PROCESS | 1663 | |2;jquery.html;372.4153079664926;374.89690335157843;378.2001067741726;380.516743735456;384.623069391996;19982.7002594961;20456.89771551142;20608;21255.362339129813;21273.255436059742;20145.59708805823;20233.291834785785;20457.897710511428;20587;20641.483962900937;4915.729634870081;5115.488451154883;5403.78384864605;5405.864853378657;5406;3774.3583590789494;5651.519620832234;5917.112433135021;5917.437843404869;5927.88144237115;5834.445727655887;5892.675902825343;5896.587238893279;5900.498457631106;5901.645901245939;5695.288088988877;5878.382769809194;5898.911516327215;5912.9113063304085;5934.5845790794665;5471.015217260891;5636;5668.68822214778;5673.404292549264;5744;25295.62056569153;25460.36349091269;25648;25683.871580642164;26059.478810423687;2028.4928767808049;2120.893955302244;2146.6887301341376;2237.6196046672103;2548.694156701189;10192.643257485952;10215.489225538693;10741.83887241692;11860.406979650983;15280.617984550365;1717.6607570246524;1736.8784185107047;1758;1760.8290486826245;1781.2607767776358;90574;95232.52383738037;97545;99215;100116;11227.887721122685;11542.711432214262;11571.305721656727;11598.536058557733;11678.299302041905;14129.222892740792;14278.07192532482;14305.713885722227;14357.21035343066;14370;8701.564921753887;8891.822163556693;8918.509481978424;8947.642094316154;8970.461772293684;7800.219978002267;8900;8954.552272386354;9047.502387368759;9113.407628504126;4384.7369157850635;4522.3668686383935;4554.7039442436135;4576.839810606612;4604.010137820318;1859.6094820087933;1873.2506997200956;1954.2769175405192;1954.550453395727;1959.3338264989973;885.4642941020719;890.3278025091015;943.9150476457152;1003.8494225866178;1045.4981608827804;19648.901755491417;20315.695264571044;20876.791232087788;21028.789712102684;21195.182504358476;1005.7787286796893;1030.2736570717625;1055.9524821383056;1061.7557961668858;1068.4978060311641;11103.44482775858;11361.659150225507;11381.374024428571;11414.315141091562;11453.656390308304;602313;602761;618529;628988;629216;77917.83123253156;94152.52923735474;124880;128478.35760821136;128863;1014.7310962594918;1025.8717660292464;1032.83990981398;1046.8743750749807;1109.3454861631676;18066.548336291173;18088.63822723512;18221.635567288315;18410.90794546019;19025.143868526226;44200;50532.24201637052;50958.74520627373;56253;56503.434965649816;59584.10623840732;78165;81675;81948;83182.58408707917;8268.627911744106;8315.542645154575;8319.126491718525;8408.915910840813;8487.490750554987;8928.86606700913;12737.80893286583;13360.532381366605;13666.385012674255;13811.585652430042;11353.943230284127;11705.531778728755;11805.881941180478;11987.160898737005;12010.459529321377;10968.835467468154;11215.60745373908;11399.943000284946;11652.650420487398;11773.587924422603;10535.894641053492;12048.277103373826;12111.212771169845;12113.970312523534;12181.878181218075;8015.7595272141925;8149.103598604267;8291.963504561929;8316.168383161878;8732.91267087321;9289.442633442015;11101.777964440827;11558.595449159575;11974.64076077719;12007.459664314953 05:26:10 INFO - PROCESS | 1663 | |3;mootools.html;1445.385711072794;1638.7050330940426;1918.8848669079857;2029.4621925189817;2035.043529541117;8197.344212463004;8825.33809964252;8904.51025193615;9137.771555711111;9145.176934075931;8934.59794309256;8959.148880856308;9081.636734530628;9083.182513573776;9099.863502047474;2379.7263314718857;2383.52329534093;2388.164142550102;2401.7958473529684;2406.2540612410207;2507.109975958536;2511.221521328394;2564.358910272432;2575.7424257574185;2591.7926565874686;2204.024263206948;2461.6307553866973;2560.641510188575;2563.551378508763;2564.358910272432;2526.406294520795;2538.2765911715164;2553.59142537195;2563.4744877300295;2568.8330258533138;2519.3071905226025;2520.785733212679;2525.267672375009;2533.5312967101145;2574.781143602796;9072.818543629157;9088;9094.454332740057;9117.589708463134;9166.587503562288;5495.505404513613;5637.154426835967;5656.688882111483;5697.658140511541;5698.886022279531;3516.753827232095;3633.454981752732;3642.908927276813;3662.816859157058;3670.1925576373155;1040.4901598216895;1055.641082032105;1056.3661802918264;1059.5761695321855;1061.7186445591924;12247.69380765479;12271.877281227164;12384.876151238463;12411.503539858395;12418.81371779424;4954.9009019819405;4977.751112444364;5035.345405097314;5059.848204553869;5079.263506791494;10360.481975901175;10402.5838966442;10423.68728938118;10427.895721042692;10444.738881528023;5602.579806514527;5616.803411880564;5626.43735626434;5635.605507614428;5664.461876121762;4503.842365517191;4966.801327946841;5056.696598204119;5058.873528161826;5117.488251174927;4064.6545043671617;4068.4144256255304;4118.402831589463;4146.440230568895;4159.9792001039805;1265.8038004109378;1334.9799753003713;1337.2615599720518;1341.9146904345073;1366.9931650341684;1396.2809153286066;1421.2822524625205;1430.4921752777614;1438.6331485471137;1453.1789538910482;8355;8505;8509.829803404022;8538.146185381536;8550.1449855014;518.1036806325079;519.5090639345857;520.1002266079703;522.9058769421465;530.9177077552986;5437.619366644376;6304;6373.71318290678;6391.520635952322;6397.872042559123;10739.409332486788;11068.944655276671;11171.385573793357;11252.49363778632;11259.437028148724;10577.31247468912;10884.23810333285;10979.945100274448;11055.336679799077;11085.556577736801;8483.872741908875;8499.74500764978;8538.658453661908;8683.696070637623;8721.476711397336;8025.317847982987;8137.79655508617;8190.754277371689;8230.588470576327;8333.208345207195;9451;9770.511474426392;9788.412695238309;9799.951000244953;9879.555420005972;9961.800763984535;10096.242781791541;10135.442550659785;10150;10158.746031349276;7546.962265188639;7554.395648348009;7607.809804754704;7611.695532178651;7694.923050769421;8311;8338.958305208678;8339.041010283894;8350.498970061573;8355.540445275568;7472.514286571355;7697.730579429693;7728.304452599293;7764.650590723544;7785.727499537489;5903.704814759159;7427.851442971219;7445.181030086795;7580.9620951894885;7668.424868134801;7878.172791857001;8036.87944680842;8075.636596353061;8095.878561821695;8110.878336825071;7213.71145154188;7271.636418178964;7281.526700764433;7306.926930730838;7342.155652099863;7300.379467745302;7315.122185337794;7323.450741194538;7359.77920662381;7393.852122957618 05:26:10 INFO - PROCESS | 1663 | |4;prototype.html;332.7952810824814;336.8770398804437;340.7699802633225;342.6316709537247;347.9251960828423;6639.302873198317;6640.9374500079875;6677.565958212713;6677.833054173642;6707.966460167704;6611.438027767634;6669.266380698119;6671.866562668756;6676.866462670744;6685.43173830225;4684.812607495714;4804.783784729696;4891.8777030574165;4895.828645997391;4942.233953737167;3905.648491635752;4847.563719265266;4866.440359358666;4880;4882.974575339165;4813.951860481386;4824.903501929959;4829.806807727687;4831.299461578069;4854.247591623286;4846.0550192712435;4846.68496547725;4848.660593758421;4860.562549370538;4879.097366987119;4200.894977625553;4208.200441916057;4216.093539888908;4221.451211342536;4226.809793559297;6227.011807627877;6270.6864656766975;6409.262934762469;6417.422431981144;6461.418472337512;5425.860569280456;5445.83662490126;5862.179294898718;5883.146943693183;5904.291485021782;7139.82150446243;7144.964275178643;7163.928360716378;7183.712651493986;7188.604626745527;4721.716696998191;4731.195696731564;4744.217204161309;4744.525547445228;4760.119377915063;7571.924280757177;7584.696612135508;7593.164751877289;7593.240675932418;7603.733869314603;3791.2227993261317;4466.151431228056;4657.883552911204;4810.975945120322;4814.687045342112;4666.113438446752;4722.031983443386;4724.362211101526;4729.763511824395;4757.976210118927;5007.47421520735;5628.465295796893;5656.745446454919;5659.066254068115;5664.178694089416;6650.53446258767;7150.284971502912;7159.534630249122;7164.21193668696;7191.748288809867;1609.6861112083266;1633.8529532342147;1634.3462614953876;1635.2641311409675;1640.3930545697929;1014.8731408573929;1045.9529321180564;1052.9789404211872;1057.2757661002238;1065.5258410007627;6630.403263706193;6676;6705.966470167618;6719.227288861745;6721.630310332881;7428.962855185798;7432.814179645552;7433.888491672629;7436.702531898772;7472.962635186898;6496.447801936793;6564.343565643398;6765.594064356154;6803.455723542104;6841.965790171117;3932.075962148893;3979.781112038808;3981.303271927401;3990.082281075369;3997.9400308995387;7911.564863932539;7916.683332666744;7917.920820791718;7928.1675424080795;7936.642851071716;7429.405647548183;7754.806129846799;7775.650095745592;7810.29707326332;7825.686972521149;6607.405333520006;7796.337311328487;7817.960910195527;7835.059792824897;7878.212178782191;7096.822579435349;7515.361194298327;7531.3598344141365;7539.736109236151;7558;6000.849978750566;7376.668049937873;7382.2617738225745;7383.520071195355;7437.776866694008;7579.886301705368;7838.64726087316;7910.367170626451;7918.564478953713;7925.0886148093705;4660.254359302496;4666.973265881501;4705.529447055267;4720.339152518719;4736.834210802605;7458.291462311072;7459.701611935679;7464.477486575887;7498.437617178624;7526.360259377795;5836.824895253149;7217.6030318333;7236.674349654173;7241.203467618663;7276.199618042117;7025.437964962688;7095.432365410858;7207.9279207207255;7217.170025447141;7264.709411623688;6185.597936134137;6363.745450182126;7047.436205103682;7047.577145371294;7082.114735658043;5225.869353266199;6592.373724496165;7240.674169662272;7256.854862902818;7263.273672632906;5881.441263080001;6193.009118541192;7061.576305421691;7064.964675176591;7106 05:26:10 INFO - PROCESS | 1663 | |5;yui.html;669.334012657406;701.1586096683978;764.121260550367;778.8247644280037;784.6861255497801;12140.392980350991;14855.480058197965;15216.77174842377;15256.466023689172;15394.846051539482;11520.827187592193;11522.308661480318;14105;14106.224157671324;14127.646808829784;761.7143571160815;957.7270477913761;957.8563215517676;970.277143528069;970.6020531582053;913.3332667152982;926.5135803703076;931.4225180388135;934.2059249637822;942.575840871607;992.8659630949837;1039.9964034706506;1042.2079219792936;1042.9947850260776;1048.6067724603274;1002.3735165521549;1023.2785885950424;1024.7643042100358;1028.7273872423814;1033.013472134114;782.953022818627;787.5078076202374;789.1004255149135;789.3409003482042;791.5962858941923;12071.456784444721;15119.319630616648;15226.46707365248;15231.162286074261;15290.082595044332;12685.93657031709;12939.158954667917;13027.934860325733;13076.476940922352;13132.212067275994;10073;10169.186465082776;10265.076143147078;10546.736331591772;10633.096186824128;3523.119220194951;3556.3242983833247;3586.246888153491;3648.7445878788494;3819.8472061117523;82375;82973.58513207456;83457.58271208666;84950.72573911396;85153.57423212906;9577.569009394594;9689.40124879387;9720.805583888425;9847.261455390875;9945.502724863727;21861.906904654705;22130.336089917328;22217.22239721602;22948.311550653507;22997.08011679514;7534.35957943581;7649.617519124133;7799.220077992269;7881.330086942674;7918;3542.7600339880837;3874.8837534874;4004.3593025115842;4013.2374848779223;4078.979605102015;3107.9689203107678;3579.856805727794;3615.457681347766;3655.2324011957253;3661.5606127264364;656.2617055812211;668.5420486966443;672.5561129654404;677.5054210426416;682.7712716240115;590.5187272373003;591.2668291318734;592.4253474130087;602.1870474858993;612.8784324685814;7942.205779422012;7970.322522585529;8022.318102961313;8236.176382361717;8266.669333226724;475.60524764445427;492.97042177469467;578.6159783217121;580.6022874331097;606.8118883146238;3599.880501892064;3805.980970095132;3812;3864.1885204107452;3891.7081218908697;90388;96203;97879.021209787;99237.5114373285;99523.01430957083;76687.61656191683;77910.61044694741;78218;78672.60663696645;79766.20233797704;71157.2884271161;71721.2827871725;72285.2771472289;72394;72398;7626.733064342721;7791.883121753292;7876.566788826441;7954.965854438886;8087.393445491494;48372.06511739632;49880;50548.74725626349;51376;51618.22572661488;56786.71606642105;68515.28711782246;70303.64848175932;71210.64394677994;73187.26812731805;9823.557939892578;9931.404115753077;10171.898281017391;10229.693109206735;10756.677299681021;10658.573657053632;10701.732456688645;10802.459877006275;11001.504932277907;11609.419529023346;10143.137833284254;10202.38785672862;10310.536025879004;10365.481725913523;10677.359358438518;10120.59517619287;10182.185425166117;10248.805732484196;10303.433311167957;10524.736881577715;10207.54066067014;10227.43749093807;10814.405207713651;10817.729556761144;11004.889951100708;8729.47623142588;8984;8987.505687187268;9002;9116.498592577473;8612.65549378018;8994.460332380078;8995.730128096167;9026.819463610822;9041.68354107603 05:26:10 INFO - PROCESS | 1663 | __end_tp_report 05:26:10 INFO - PROCESS | 1663 | __start_cc_report 05:26:10 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,359 05:26:10 INFO - PROCESS | 1663 | __end_cc_report 05:26:10 INFO - PROCESS | 1663 | __startTimestamp1460031970132__endTimestamp 05:26:10 INFO - PROCESS | 1663 | 05:26:10 INFO - PROCESS | 1663 | ------- Summary: start ------- 05:26:10 INFO - PROCESS | 1663 | Number of tests: 6 05:26:10 INFO - PROCESS | 1663 | 05:26:10 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5796.37 Median:6075.18 stddev:688.76 (11.3%) stddev-sans-first:659.24 05:26:10 INFO - PROCESS | 1663 | Values: 3166.0 3536.0 3543.4 3571.6 3598.1 5763.1 5766.7 5784.8 5792.0 5818.2 5076.0 5393.2 5774.1 5817.6 5874.4 4540.0 4974.8 5244.8 5259.6 5296.8 5160.4 5273.8 5297.3 5342.2 5398.4 4400.4 5298.9 5299.4 5305.3 5305.8 5242.9 5247.4 5283.0 5298.5 5382.2 4677.9 5079.5 5162.7 5228.4 5339.6 5759.4 5793.2 5802.8 5812.6 5853.2 5897.7 6115.5 6299.2 6331.2 6371.4 5961.9 6297.1 6318.1 6326.0 6326.5 4851.3 5937.0 5955.7 6012.5 6016.7 6256.0 6262.5 6293.6 6426.8 6459.5 6154.6 6155.7 6177.8 6184.3 6216.5 6279.6 6298.4 6305.3 6308.7 6315.6 6172.7 6216.8 6236.7 6290.1 6341.3 6266.0 6306.4 6311.1 6311.3 6347.2 4953.9 4973.2 5004.4 5015.5 5049.9 4363.0 4372.0 4420.1 4460.4 4512.5 6011.2 6031.1 6054.2 6069.3 6071.7 6225.8 6310.3 6337.7 6352.0 6368.8 5760.1 5924.1 5978.9 6017.5 6063.6 5455.1 5459.7 5461.2 5495.2 5498.6 6352.8 6540.1 6541.2 6543.6 6555.3 6225.2 6267.3 6282.0 6313.2 6313.4 6465.2 6484.4 6485.8 6487.2 6502.9 6132.7 6189.6 6315.1 6326.6 6332.9 6273.1 6290.8 6311.4 6314.8 6317.9 6215.6 6229.3 6259.2 6266.7 6305.4 6124.4 6132.0 6155.9 6205.4 6294.1 6004.8 6075.2 6128.1 6131.9 6139.8 6244.4 6251.2 6270.2 6291.2 6297.4 4425.8 4965.3 5243.8 5772.7 6186.5 05:26:10 INFO - PROCESS | 1663 | 05:26:10 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:63669.39 Median:39795.60 stddev:134191.29 (337.2%) stddev-sans-first:134483.97 05:26:10 INFO - PROCESS | 1663 | Values: 519.6 525.7 582.6 603.0 650.4 31732.8 39104.2 40100.4 40243.4 40288.4 41465.6 41793.2 41944.6 41971.0 42318.8 9511.3 9693.1 9746.9 9756.6 9771.4 9610.5 9793.5 9795.5 9875.8 9904.9 9856.4 9873.6 9946.4 9952.2 9961.5 9833.7 9886.7 9919.6 9922.7 9923.7 7501.9 9722.6 9737.6 9829.0 9887.5 40667.2 40893.8 41088.8 41216.0 41500.4 3222.0 3294.5 3294.7 3335.7 3356.0 27964.0 29093.0 29989.7 30737.2 31101.7 2797.2 2818.5 2828.1 2854.9 2898.0 347183.0 348156.3 348351.0 350909.0 351283.0 47998.5 48690.8 48797.5 73950.9 74247.3 47395.0 48446.0 48454.0 48702.5 48846.0 17234.7 17423.7 17590.8 17598.3 17620.9 13891.3 13894.2 13954.1 13975.2 14051.7 15861.9 15897.4 15976.6 15994.4 15994.7 5503.9 5580.7 6579.3 6630.7 6675.6 985.5 1000.2 1088.9 1118.3 1140.6 30853.8 31621.0 31676.5 31844.8 32276.8 907.9 1045.0 1123.2 1211.3 1246.5 12286.8 13214.8 15459.9 15483.9 15913.8 619423.0 635074.0 637818.0 641247.0 643809.0 60704.7 66733.3 66876.0 67091.7 67176.0 1510.8 1514.3 1527.7 1549.6 1555.0 31320.4 31545.2 31552.8 31615.4 32104.7 55684.7 55875.9 56239.0 56347.7 56459.7 473256.0 483370.0 483902.0 484241.0 485799.0 34143.8 34423.7 35041.6 35673.9 36203.6 46988.8 47104.8 47275.3 48046.3 48114.5 38458.2 38728.4 39665.6 39925.6 40327.8 38113.8 38542.0 39217.0 39357.8 40138.2 32925.8 33381.5 38501.6 38827.8 40085.0 26616.3 31188.5 31911.7 33015.3 33357.5 25654.5 25790.0 25974.1 25979.7 26017.5 05:26:10 INFO - PROCESS | 1663 | 05:26:10 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:34494.08 Median:11709.97 stddev:101937.68 (870.5%) stddev-sans-first:102191.45 05:26:10 INFO - PROCESS | 1663 | Values: 372.4 374.9 378.2 380.5 384.6 19982.7 20456.9 20608.0 21255.4 21273.3 20145.6 20233.3 20457.9 20587.0 20641.5 4915.7 5115.5 5403.8 5405.9 5406.0 3774.4 5651.5 5917.1 5917.4 5927.9 5834.4 5892.7 5896.6 5900.5 5901.6 5695.3 5878.4 5898.9 5912.9 5934.6 5471.0 5636.0 5668.7 5673.4 5744.0 25295.6 25460.4 25648.0 25683.9 26059.5 2028.5 2120.9 2146.7 2237.6 2548.7 10192.6 10215.5 10741.8 11860.4 15280.6 1717.7 1736.9 1758.0 1760.8 1781.3 90574.0 95232.5 97545.0 99215.0 100116.0 11227.9 11542.7 11571.3 11598.5 11678.3 14129.2 14278.1 14305.7 14357.2 14370.0 8701.6 8891.8 8918.5 8947.6 8970.5 7800.2 8900.0 8954.6 9047.5 9113.4 4384.7 4522.4 4554.7 4576.8 4604.0 1859.6 1873.3 1954.3 1954.6 1959.3 885.5 890.3 943.9 1003.8 1045.5 19648.9 20315.7 20876.8 21028.8 21195.2 1005.8 1030.3 1056.0 1061.8 1068.5 11103.4 11361.7 11381.4 11414.3 11453.7 602313.0 602761.0 618529.0 628988.0 629216.0 77917.8 94152.5 124880.0 128478.4 128863.0 1014.7 1025.9 1032.8 1046.9 1109.3 18066.5 18088.6 18221.6 18410.9 19025.1 44200.0 50532.2 50958.7 56253.0 56503.4 59584.1 78165.0 81675.0 81948.0 83182.6 8268.6 8315.5 8319.1 8408.9 8487.5 8928.9 12737.8 13360.5 13666.4 13811.6 11353.9 11705.5 11805.9 11987.2 12010.5 10968.8 11215.6 11399.9 11652.7 11773.6 10535.9 12048.3 12111.2 12114.0 12181.9 8015.8 8149.1 8292.0 8316.2 8732.9 9289.4 11101.8 11558.6 11974.6 12007.5 05:26:10 INFO - PROCESS | 1663 | 05:26:10 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:6226.23 Median:519.80 stddev:3308.87 (636.6%) stddev-sans-first:3298.64 05:26:10 INFO - PROCESS | 1663 | Values: 1445.4 1638.7 1918.9 2029.5 2035.0 8197.3 8825.3 8904.5 9137.8 9145.2 8934.6 8959.1 9081.6 9083.2 9099.9 2379.7 2383.5 2388.2 2401.8 2406.3 2507.1 2511.2 2564.4 2575.7 2591.8 2204.0 2461.6 2560.6 2563.6 2564.4 2526.4 2538.3 2553.6 2563.5 2568.8 2519.3 2520.8 2525.3 2533.5 2574.8 9072.8 9088.0 9094.5 9117.6 9166.6 5495.5 5637.2 5656.7 5697.7 5698.9 3516.8 3633.5 3642.9 3662.8 3670.2 1040.5 1055.6 1056.4 1059.6 1061.7 12247.7 12271.9 12384.9 12411.5 12418.8 4954.9 4977.8 5035.3 5059.8 5079.3 10360.5 10402.6 10423.7 10427.9 10444.7 5602.6 5616.8 5626.4 5635.6 5664.5 4503.8 4966.8 5056.7 5058.9 5117.5 4064.7 4068.4 4118.4 4146.4 4160.0 1265.8 1335.0 1337.3 1341.9 1367.0 1396.3 1421.3 1430.5 1438.6 1453.2 8355.0 8505.0 8509.8 8538.1 8550.1 518.1 519.5 520.1 522.9 530.9 5437.6 6304.0 6373.7 6391.5 6397.9 10739.4 11068.9 11171.4 11252.5 11259.4 10577.3 10884.2 10979.9 11055.3 11085.6 8483.9 8499.7 8538.7 8683.7 8721.5 8025.3 8137.8 8190.8 8230.6 8333.2 9451.0 9770.5 9788.4 9800.0 9879.6 9961.8 10096.2 10135.4 10150.0 10158.7 7547.0 7554.4 7607.8 7611.7 7694.9 8311.0 8339.0 8339.0 8350.5 8355.5 7472.5 7697.7 7728.3 7764.7 7785.7 5903.7 7427.9 7445.2 7581.0 7668.4 7878.2 8036.9 8075.6 8095.9 8110.9 7213.7 7271.6 7281.5 7306.9 7342.2 7300.4 7315.1 7323.5 7359.8 7393.9 05:26:10 INFO - PROCESS | 1663 | 05:26:10 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:5833.27 Median:6609.42 stddev:1894.98 (28.7%) stddev-sans-first:1854.78 05:26:10 INFO - PROCESS | 1663 | Values: 332.8 336.9 340.8 342.6 347.9 6639.3 6640.9 6677.6 6677.8 6708.0 6611.4 6669.3 6671.9 6676.9 6685.4 4684.8 4804.8 4891.9 4895.8 4942.2 3905.6 4847.6 4866.4 4880.0 4883.0 4814.0 4824.9 4829.8 4831.3 4854.2 4846.1 4846.7 4848.7 4860.6 4879.1 4200.9 4208.2 4216.1 4221.5 4226.8 6227.0 6270.7 6409.3 6417.4 6461.4 5425.9 5445.8 5862.2 5883.1 5904.3 7139.8 7145.0 7163.9 7183.7 7188.6 4721.7 4731.2 4744.2 4744.5 4760.1 7571.9 7584.7 7593.2 7593.2 7603.7 3791.2 4466.2 4657.9 4811.0 4814.7 4666.1 4722.0 4724.4 4729.8 4758.0 5007.5 5628.5 5656.7 5659.1 5664.2 6650.5 7150.3 7159.5 7164.2 7191.7 1609.7 1633.9 1634.3 1635.3 1640.4 1014.9 1046.0 1053.0 1057.3 1065.5 6630.4 6676.0 6706.0 6719.2 6721.6 7429.0 7432.8 7433.9 7436.7 7473.0 6496.4 6564.3 6765.6 6803.5 6842.0 3932.1 3979.8 3981.3 3990.1 3997.9 7911.6 7916.7 7917.9 7928.2 7936.6 7429.4 7754.8 7775.7 7810.3 7825.7 6607.4 7796.3 7818.0 7835.1 7878.2 7096.8 7515.4 7531.4 7539.7 7558.0 6000.8 7376.7 7382.3 7383.5 7437.8 7579.9 7838.6 7910.4 7918.6 7925.1 4660.3 4667.0 4705.5 4720.3 4736.8 7458.3 7459.7 7464.5 7498.4 7526.4 5836.8 7217.6 7236.7 7241.2 7276.2 7025.4 7095.4 7207.9 7217.2 7264.7 6185.6 6363.7 7047.4 7047.6 7082.1 5225.9 6592.4 7240.7 7256.9 7263.3 5881.4 6193.0 7061.6 7065.0 7106.0 05:26:10 INFO - PROCESS | 1663 | 05:26:10 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:18412.29 Median:579.61 stddev:26480.35 (4568.7%) stddev-sans-first:26521.12 05:26:10 INFO - PROCESS | 1663 | Values: 669.3 701.2 764.1 778.8 784.7 12140.4 14855.5 15216.8 15256.5 15394.8 11520.8 11522.3 14105.0 14106.2 14127.6 761.7 957.7 957.9 970.3 970.6 913.3 926.5 931.4 934.2 942.6 992.9 1040.0 1042.2 1043.0 1048.6 1002.4 1023.3 1024.8 1028.7 1033.0 783.0 787.5 789.1 789.3 791.6 12071.5 15119.3 15226.5 15231.2 15290.1 12685.9 12939.2 13027.9 13076.5 13132.2 10073.0 10169.2 10265.1 10546.7 10633.1 3523.1 3556.3 3586.2 3648.7 3819.8 82375.0 82973.6 83457.6 84950.7 85153.6 9577.6 9689.4 9720.8 9847.3 9945.5 21861.9 22130.3 22217.2 22948.3 22997.1 7534.4 7649.6 7799.2 7881.3 7918.0 3542.8 3874.9 4004.4 4013.2 4079.0 3108.0 3579.9 3615.5 3655.2 3661.6 656.3 668.5 672.6 677.5 682.8 590.5 591.3 592.4 602.2 612.9 7942.2 7970.3 8022.3 8236.2 8266.7 475.6 493.0 578.6 580.6 606.8 3599.9 3806.0 3812.0 3864.2 3891.7 90388.0 96203.0 97879.0 99237.5 99523.0 76687.6 77910.6 78218.0 78672.6 79766.2 71157.3 71721.3 72285.3 72394.0 72398.0 7626.7 7791.9 7876.6 7955.0 8087.4 48372.1 49880.0 50548.7 51376.0 51618.2 56786.7 68515.3 70303.6 71210.6 73187.3 9823.6 9931.4 10171.9 10229.7 10756.7 10658.6 10701.7 10802.5 11001.5 11609.4 10143.1 10202.4 10310.5 10365.5 10677.4 10120.6 10182.2 10248.8 10303.4 10524.7 10207.5 10227.4 10814.4 10817.7 11004.9 8729.5 8984.0 8987.5 9002.0 9116.5 8612.7 8994.5 8995.7 9026.8 9041.7 05:26:10 INFO - PROCESS | 1663 | -------- Summary: end -------- 05:26:10 INFO - PROCESS | 1663 | 05:26:10 INFO - TEST-INFO | 1663: exit 0 05:26:10 INFO - TEST-OK | dromaeo_css | took 1110064ms 05:26:10 INFO - TEST-START | kraken 05:26:10 INFO - operating with platform_type : mac_ 05:26:10 INFO - Initialising browser for kraken test... 05:26:10 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmp5vzc5x/profile http://localhost:49272/getInfo.html) 05:26:13 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 05:26:13 INFO - PROCESS | 1675 | colorDepth:24 05:26:13 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 05:26:13 INFO - PROCESS | 1675 | __metrics 05:26:13 ERROR - PROCESS | 1675 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 05:26:13 INFO - TEST-INFO | 1675: exit 0 05:26:13 INFO - Browser initialized. 05:26:13 INFO - Running cycle 1/1 for kraken test... 05:26:13 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmp5vzc5x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:26:25 INFO - PROCESS | 1678 | RSS: Main: 218247168 05:26:25 INFO - PROCESS | 1678 | 05:26:28 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 05:26:29 INFO - PROCESS | 1678 | RSS: Main: 229842944 05:26:29 INFO - PROCESS | 1678 | 05:26:31 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 05:26:32 INFO - PROCESS | 1678 | RSS: Main: 239308800 05:26:32 INFO - PROCESS | 1678 | 05:26:35 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 05:26:36 INFO - PROCESS | 1678 | RSS: Main: 243064832 05:26:36 INFO - PROCESS | 1678 | 05:26:38 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 05:26:38 INFO - PROCESS | 1678 | RSS: Main: 244559872 05:26:38 INFO - PROCESS | 1678 | 05:26:40 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:26:41 INFO - PROCESS | 1678 | RSS: Main: 245182464 05:26:41 INFO - PROCESS | 1678 | 05:26:44 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 05:26:44 INFO - PROCESS | 1678 | RSS: Main: 244633600 05:26:44 INFO - PROCESS | 1678 | 05:26:48 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 05:26:48 INFO - PROCESS | 1678 | RSS: Main: 245006336 05:26:48 INFO - PROCESS | 1678 | 05:26:51 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 05:26:52 INFO - PROCESS | 1678 | RSS: Main: 245325824 05:26:52 INFO - PROCESS | 1678 | 05:26:53 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:26:54 INFO - PROCESS | 1678 | RSS: Main: 245211136 05:26:54 INFO - PROCESS | 1678 | 05:26:56 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:26:56 INFO - PROCESS | 1678 | RSS: Main: 244301824 05:26:56 INFO - PROCESS | 1678 | 05:26:58 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:26:59 INFO - PROCESS | 1678 | RSS: Main: 245084160 05:26:59 INFO - PROCESS | 1678 | 05:27:02 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:27:02 INFO - PROCESS | 1678 | RSS: Main: 245329920 05:27:02 INFO - PROCESS | 1678 | 05:27:05 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:27:05 INFO - PROCESS | 1678 | RSS: Main: 245542912 05:27:05 INFO - PROCESS | 1678 | 05:27:07 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 05:27:07 INFO - PROCESS | 1678 | RSS: Main: 246505472 05:27:07 INFO - PROCESS | 1678 | 05:27:07 INFO - PROCESS | 1678 | __start_tp_report 05:27:07 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 05:27:07 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 05:27:07 INFO - PROCESS | 1678 | |i|pagename|runs| 05:27:07 INFO - PROCESS | 1678 | |0;ai-astar;116;113;117;116;117;128;114;114;114;115 05:27:07 INFO - PROCESS | 1678 | |1;audio-beat-detection;147;120;145;148;119;175;155;150;147;119 05:27:07 INFO - PROCESS | 1678 | |2;audio-dft;195;197;192;205;200;198;199;194;193;284 05:27:07 INFO - PROCESS | 1678 | |3;audio-fft;67;71;69;104;52;57;58;60;120;56 05:27:07 INFO - PROCESS | 1678 | |4;audio-oscillator;82;78;123;95;117;71;102;82;98;152 05:27:07 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;91;87;78;129;94;86;111;87;136;130 05:27:07 INFO - PROCESS | 1678 | |6;imaging-darkroom;150;149;108;149;90;98;143;149;117;148 05:27:07 INFO - PROCESS | 1678 | |7;imaging-desaturate;90;91;89;89;90;96;90;90;90;88 05:27:07 INFO - PROCESS | 1678 | |8;json-parse-financial;58;62;61;58;61;60;61;69;87;41 05:27:07 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;63;62;68;68;71;72;66;67;57;74 05:27:07 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;83;83;81;84;101;108;109;108;82;85 05:27:07 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;120;120;124;123;124;135;134;113;120;123 05:27:07 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;118;179;122;167;171;175;165;131;138;137 05:27:07 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;64;68;67;66;68;67;64;66;67;64 05:27:07 INFO - PROCESS | 1678 | __end_tp_report 05:27:07 INFO - PROCESS | 1678 | __start_cc_report 05:27:07 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,923 05:27:07 INFO - PROCESS | 1678 | __end_cc_report 05:27:07 INFO - PROCESS | 1678 | __startTimestamp1460032027795__endTimestamp 05:27:07 INFO - PROCESS | 1678 | 05:27:07 INFO - PROCESS | 1678 | ------- Summary: start ------- 05:27:07 INFO - PROCESS | 1678 | Number of tests: 14 05:27:07 INFO - PROCESS | 1678 | 05:27:07 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:116.40 Median:116.00 stddev:4.30 (3.7%) stddev-sans-first:4.56 05:27:07 INFO - PROCESS | 1678 | Values: 116.0 113.0 117.0 116.0 117.0 128.0 114.0 114.0 114.0 115.0 05:27:07 INFO - PROCESS | 1678 | 05:27:07 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:147.50 stddev:18.12 (12.3%) stddev-sans-first:19.15 05:27:07 INFO - PROCESS | 1678 | Values: 147.0 120.0 145.0 148.0 119.0 175.0 155.0 150.0 147.0 119.0 05:27:07 INFO - PROCESS | 1678 | 05:27:07 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:205.70 Median:198.50 stddev:27.78 (14.0%) stddev-sans-first:29.19 05:27:07 INFO - PROCESS | 1678 | Values: 195.0 197.0 192.0 205.0 200.0 198.0 199.0 194.0 193.0 284.0 05:27:07 INFO - PROCESS | 1678 | 05:27:07 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:71.40 Median:59.00 stddev:22.56 (38.2%) stddev-sans-first:23.87 05:27:07 INFO - PROCESS | 1678 | Values: 67.0 71.0 69.0 104.0 52.0 57.0 58.0 60.0 120.0 56.0 05:27:07 INFO - PROCESS | 1678 | 05:27:07 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:100.00 Median:80.00 stddev:24.78 (31.0%) stddev-sans-first:25.42 05:27:07 INFO - PROCESS | 1678 | Values: 82.0 78.0 123.0 95.0 117.0 71.0 102.0 82.0 98.0 152.0 05:27:07 INFO - PROCESS | 1678 | 05:27:07 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:102.90 Median:86.50 stddev:21.63 (25.0%) stddev-sans-first:22.50 05:27:07 INFO - PROCESS | 1678 | Values: 91.0 87.0 78.0 129.0 94.0 86.0 111.0 87.0 136.0 130.0 05:27:07 INFO - PROCESS | 1678 | 05:27:07 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:130.10 Median:149.00 stddev:24.16 (16.2%) stddev-sans-first:24.53 05:27:07 INFO - PROCESS | 1678 | Values: 150.0 149.0 108.0 149.0 90.0 98.0 143.0 149.0 117.0 148.0 05:27:07 INFO - PROCESS | 1678 | 05:27:07 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:90.30 Median:90.00 stddev:2.16 (2.4%) stddev-sans-first:2.29 05:27:07 INFO - PROCESS | 1678 | Values: 90.0 91.0 89.0 89.0 90.0 96.0 90.0 90.0 90.0 88.0 05:27:07 INFO - PROCESS | 1678 | 05:27:07 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:61.80 Median:61.00 stddev:11.32 (18.6%) stddev-sans-first:11.92 05:27:07 INFO - PROCESS | 1678 | Values: 58.0 62.0 61.0 58.0 61.0 60.0 61.0 69.0 87.0 41.0 05:27:07 INFO - PROCESS | 1678 | 05:27:07 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:68.00 stddev:5.09 (7.5%) stddev-sans-first:5.21 05:27:07 INFO - PROCESS | 1678 | Values: 63.0 62.0 68.0 68.0 71.0 72.0 66.0 67.0 57.0 74.0 05:27:07 INFO - PROCESS | 1678 | 05:27:07 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:92.40 Median:82.50 stddev:12.37 (15.0%) stddev-sans-first:12.64 05:27:07 INFO - PROCESS | 1678 | Values: 83.0 83.0 81.0 84.0 101.0 108.0 109.0 108.0 82.0 85.0 05:27:07 INFO - PROCESS | 1678 | 05:27:07 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:123.50 stddev:6.59 (5.3%) stddev-sans-first:6.86 05:27:07 INFO - PROCESS | 1678 | Values: 120.0 120.0 124.0 123.0 124.0 135.0 134.0 113.0 120.0 123.0 05:27:07 INFO - PROCESS | 1678 | 05:27:07 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.30 Median:166.00 stddev:23.34 (14.1%) stddev-sans-first:21.63 05:27:07 INFO - PROCESS | 1678 | Values: 118.0 179.0 122.0 167.0 171.0 175.0 165.0 131.0 138.0 137.0 05:27:07 INFO - PROCESS | 1678 | 05:27:07 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:67.00 stddev:1.60 (2.4%) stddev-sans-first:1.50 05:27:07 INFO - PROCESS | 1678 | Values: 64.0 68.0 67.0 66.0 68.0 67.0 64.0 66.0 67.0 64.0 05:27:07 INFO - PROCESS | 1678 | -------- Summary: end -------- 05:27:07 INFO - PROCESS | 1678 | 05:27:08 INFO - TEST-INFO | 1678: exit 0 05:27:08 INFO - TEST-OK | kraken | took 57860ms 05:27:08 INFO - SUITE-END | took 1167s 05:27:08 INFO - Completed test suite (00:19:28) 05:27:08 INFO - javascript benchmark 05:27:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3165.98417007915, 3535.9823200883993, 3543.4330507118866, 3571.5535558055244, 3598.0645032291595, 5763.0779075347955, 5766.682832444214, 5784.826455206346, 5792.044312688412, 5818.214541036964, 5076.0, 5393.217983392406, 5774.133879918015, 5817.621854579449, 5874.412558744123, 4540.023894862604, 4974.751262436882, 5244.846133850547, 5259.631825772198, 5296.788128474856, 5160.380754309488, 5273.762680679379, 5297.311349524556, 5342.198670199462, 5398.406175320712, 4400.383946247512, 5298.867528311804, 5299.417064122943, 5305.257263983045, 5305.840824775243, 5242.8689282767855, 5247.449017853109, 5283.049051170788, 5298.549623282006, 5382.165764306539, 4677.947461821063, 5079.517445842639, 5162.664426812245, 5228.398734145584, 5339.5728341732565, 5759.424057594207, 5793.159991801207, 5802.796902108406, 5812.5640576956475, 5853.151293062525, 5897.675627840467, 6115.544587952024, 6299.244090709099, 6331.2085989251345, 6371.426571608577, 5961.850953726148, 6297.0554416837385, 6318.083877837687, 6325.96837015812, 6326.5255105867245, 4851.296561998526, 5936.97031514844, 5955.672438015908, 6012.518998480111, 6016.669083200466, 6255.96872015637, 6262.530310226751, 6293.590916590407, 6426.775062872777, 6459.450946669492, 6154.630722156685, 6155.692215389213, 6177.81466556004, 6184.288806787187, 6216.471599913967, 6279.560430769802, 6298.433141017331, 6305.274893387227, 6308.716107775161, 6315.621062736251, 6172.69136543171, 6216.751329946842, 6236.719347629368, 6290.056491526308, 6341.3341599132345, 6266.0, 6306.432421082125, 6311.147995020705, 6311.305756366796, 6347.206599175103, 4953.851384458472, 4973.154563724175, 5004.374453193351, 5015.523525265094, 5049.9495005049475, 4363.0, 4372.016296333363, 4420.115976804652, 4460.397846290774, 4512.458504979423, 6011.158437818709, 6031.125486804476, 6054.152418661391, 6069.332373438918, 6071.696415179224, 6225.8132256032395, 6310.274318453345, 6337.746490140343, 6351.96824015877, 6368.77709280173, 5760.107183386582, 5924.052151655715, 5978.940210597925, 6017.548683848641, 6063.636181829104, 5455.099908515051, 5459.672419654833, 5461.1808228766, 5495.230667706524, 5498.5876059294915, 6352.777652782131, 6540.051692504655, 6541.247756508063, 6543.607383557001, 6555.311692272338, 6225.190725205875, 6267.341929097379, 6281.96859015702, 6313.2424109107205, 6313.368663133833, 6465.191851018622, 6484.383983521558, 6485.77299794505, 6487.18910136233, 6502.902456463063, 6132.662703551169, 6189.6286222826775, 6315.115883776183, 6326.620402775849, 6332.905006424815, 6273.090401891609, 6290.842728931813, 6311.368863113652, 6314.84212894663, 6317.905231421624, 6215.595986260879, 6229.345918678655, 6259.155014073224, 6266.749330026748, 6305.432511074026, 6124.448799608057, 6132.04958718918, 6155.907661385172, 6205.379462053939, 6294.0558916162945, 6004.759809607567, 6075.1798507200965, 6128.050152226234, 6131.896258673303, 6139.815805525842, 6244.438000579969, 6251.151672103534, 6270.15352927349, 6291.231857982473, 6297.4017468340435, 4425.800838962319, 4965.329680493087, 5243.8164664236565, 5772.6536407815665, 6186.5360097993735], "unit": "score", "name": "dojo.html", "value": 5752.34912189126}, {"lowerIsBetter": false, "replicates": [519.6154845414393, 525.6845892464522, 582.6009183709159, 602.9577929544928, 650.385385810409, 31732.841335793288, 39104.21791564167, 40100.398494022615, 40243.396349054754, 40288.39567406488, 41465.58534414655, 41793.16413671725, 41944.58055419445, 41971.0, 42318.78840605792, 9511.28665350098, 9693.127618514332, 9746.902530974707, 9756.560954757017, 9771.364861283993, 9610.519474026305, 9793.461359625218, 9795.510224488782, 9875.802483950316, 9904.90095099047, 9856.35933664313, 9873.555689993931, 9946.353487023356, 9952.154066904322, 9961.501924903761, 9833.704988850346, 9886.653967111153, 9919.553620087114, 9922.702318930444, 9923.65267215644, 7501.924980750177, 9722.562484688206, 9737.610495580167, 9829.0, 9887.505624718735, 40667.186656267004, 40893.79553102245, 41088.79455602703, 41216.0, 41500.37749433761, 3221.983890080558, 3294.5387645729616, 3294.6540613235743, 3335.69978701918, 3356.0, 27964.0, 29093.0, 29989.700102998908, 30737.231569210726, 31101.688983110333, 2797.230761540572, 2818.4504021715775, 2828.0808737160505, 2854.942901141986, 2897.971220216814, 347183.0, 348156.25921870227, 348351.0, 350909.0, 351283.0, 47998.5200148001, 48690.78273043202, 48797.51202488001, 73950.89073663899, 74247.25752742511, 47395.0, 48446.0, 48454.0, 48702.51297487051, 48846.0, 17234.65530689404, 17423.65152696939, 17590.768646194898, 17598.29606815713, 17620.9118954407, 13891.305434728223, 13894.166350019032, 13954.09298395601, 13975.161490310615, 14051.718965620836, 15861.920690396704, 15897.443589474544, 15976.641985431135, 15994.440194593133, 15994.680106397807, 5503.944960550343, 5580.693061881554, 6579.30917253691, 6630.701618427182, 6675.632840193836, 985.4875464758286, 1000.1898462245605, 1088.8911108889206, 1118.3234143343323, 1140.5779861451151, 30853.765849366224, 31621.0, 31676.524852127237, 31844.840775796438, 32276.83861580677, 907.9364444488822, 1045.0, 1123.2025262063862, 1211.3156066822216, 1246.4951694563715, 12286.815697764541, 13214.801777973338, 15459.917805753714, 15483.922580387027, 15913.761293580606, 619423.0, 635074.0, 637818.0, 641247.0, 643809.0, 60704.69647651822, 66733.33266667368, 66875.99686004713, 67091.6581668364, 67176.0, 1510.8262549806914, 1514.295852428626, 1527.7020980908617, 1549.5738671865101, 1555.0, 31320.37359252848, 31545.211369715023, 31552.84223578959, 31615.446018758365, 32104.67895321017, 55684.72157639348, 55875.88248234931, 56239.0, 56347.71826140843, 56459.71770141123, 473256.0, 483370.0, 483902.0, 484241.0, 485799.0, 34143.82928085344, 34423.65576344305, 35041.64958350384, 35673.92978210658, 36203.63796362003, 46988.7650561745, 47104.7644761774, 47275.29087063628, 48046.279305809745, 48114.518854811, 38458.23083538258, 38728.419073713354, 39665.60334396619, 39925.60074399219, 40327.798361008005, 38113.80943095267, 38542.0, 39217.0, 39357.80321098376, 40138.19723605453, 32925.83537082299, 33381.49927751037, 38501.6149838498, 38827.80586097051, 40085.0, 26616.334591635365, 31188.532172016985, 31911.68088319087, 33015.33969320648, 33357.499637504974, 25654.486910261316, 25790.0, 25974.09090681817, 25979.74020259773, 26017.495626093478], "unit": "score", "name": "ext.html", "value": 19824.22175013164}, {"lowerIsBetter": false, "replicates": [372.4153079664926, 374.89690335157843, 378.2001067741726, 380.516743735456, 384.623069391996, 19982.7002594961, 20456.89771551142, 20608.0, 21255.362339129813, 21273.255436059742, 20145.59708805823, 20233.291834785785, 20457.897710511428, 20587.0, 20641.483962900937, 4915.729634870081, 5115.488451154883, 5403.78384864605, 5405.864853378657, 5406.0, 3774.3583590789494, 5651.519620832234, 5917.112433135021, 5917.437843404869, 5927.88144237115, 5834.445727655887, 5892.675902825343, 5896.587238893279, 5900.498457631106, 5901.645901245939, 5695.288088988877, 5878.382769809194, 5898.911516327215, 5912.9113063304085, 5934.5845790794665, 5471.015217260891, 5636.0, 5668.68822214778, 5673.404292549264, 5744.0, 25295.62056569153, 25460.36349091269, 25648.0, 25683.871580642164, 26059.478810423687, 2028.4928767808049, 2120.893955302244, 2146.6887301341376, 2237.6196046672103, 2548.694156701189, 10192.643257485952, 10215.489225538693, 10741.83887241692, 11860.406979650983, 15280.617984550365, 1717.6607570246524, 1736.8784185107047, 1758.0, 1760.8290486826245, 1781.2607767776358, 90574.0, 95232.52383738037, 97545.0, 99215.0, 100116.0, 11227.887721122685, 11542.711432214262, 11571.305721656727, 11598.536058557733, 11678.299302041905, 14129.222892740792, 14278.07192532482, 14305.713885722227, 14357.21035343066, 14370.0, 8701.564921753887, 8891.822163556693, 8918.509481978424, 8947.642094316154, 8970.461772293684, 7800.219978002267, 8900.0, 8954.552272386354, 9047.502387368759, 9113.407628504126, 4384.7369157850635, 4522.3668686383935, 4554.7039442436135, 4576.839810606612, 4604.010137820318, 1859.6094820087933, 1873.2506997200956, 1954.2769175405192, 1954.550453395727, 1959.3338264989973, 885.4642941020719, 890.3278025091015, 943.9150476457152, 1003.8494225866178, 1045.4981608827804, 19648.901755491417, 20315.695264571044, 20876.791232087788, 21028.789712102684, 21195.182504358476, 1005.7787286796893, 1030.2736570717625, 1055.9524821383056, 1061.7557961668858, 1068.4978060311641, 11103.44482775858, 11361.659150225507, 11381.374024428571, 11414.315141091562, 11453.656390308304, 602313.0, 602761.0, 618529.0, 628988.0, 629216.0, 77917.83123253156, 94152.52923735474, 124880.0, 128478.35760821136, 128863.0, 1014.7310962594918, 1025.8717660292464, 1032.83990981398, 1046.8743750749807, 1109.3454861631676, 18066.548336291173, 18088.63822723512, 18221.635567288315, 18410.90794546019, 19025.143868526226, 44200.0, 50532.24201637052, 50958.74520627373, 56253.0, 56503.434965649816, 59584.10623840732, 78165.0, 81675.0, 81948.0, 83182.58408707917, 8268.627911744106, 8315.542645154575, 8319.126491718525, 8408.915910840813, 8487.490750554987, 8928.86606700913, 12737.80893286583, 13360.532381366605, 13666.385012674255, 13811.585652430042, 11353.943230284127, 11705.531778728755, 11805.881941180478, 11987.160898737005, 12010.459529321377, 10968.835467468154, 11215.60745373908, 11399.943000284946, 11652.650420487398, 11773.587924422603, 10535.894641053492, 12048.277103373826, 12111.212771169845, 12113.970312523534, 12181.878181218075, 8015.7595272141925, 8149.103598604267, 8291.963504561929, 8316.168383161878, 8732.91267087321, 9289.442633442015, 11101.777964440827, 11558.595449159575, 11974.64076077719, 12007.459664314953], "unit": "score", "name": "jquery.html", "value": 9573.552200330392}, {"lowerIsBetter": false, "replicates": [1445.385711072794, 1638.7050330940426, 1918.8848669079857, 2029.4621925189817, 2035.043529541117, 8197.344212463004, 8825.33809964252, 8904.51025193615, 9137.771555711111, 9145.176934075931, 8934.59794309256, 8959.148880856308, 9081.636734530628, 9083.182513573776, 9099.863502047474, 2379.7263314718857, 2383.52329534093, 2388.164142550102, 2401.7958473529684, 2406.2540612410207, 2507.109975958536, 2511.221521328394, 2564.358910272432, 2575.7424257574185, 2591.7926565874686, 2204.024263206948, 2461.6307553866973, 2560.641510188575, 2563.551378508763, 2564.358910272432, 2526.406294520795, 2538.2765911715164, 2553.59142537195, 2563.4744877300295, 2568.8330258533138, 2519.3071905226025, 2520.785733212679, 2525.267672375009, 2533.5312967101145, 2574.781143602796, 9072.818543629157, 9088.0, 9094.454332740057, 9117.589708463134, 9166.587503562288, 5495.505404513613, 5637.154426835967, 5656.688882111483, 5697.658140511541, 5698.886022279531, 3516.753827232095, 3633.454981752732, 3642.908927276813, 3662.816859157058, 3670.1925576373155, 1040.4901598216895, 1055.641082032105, 1056.3661802918264, 1059.5761695321855, 1061.7186445591924, 12247.69380765479, 12271.877281227164, 12384.876151238463, 12411.503539858395, 12418.81371779424, 4954.9009019819405, 4977.751112444364, 5035.345405097314, 5059.848204553869, 5079.263506791494, 10360.481975901175, 10402.5838966442, 10423.68728938118, 10427.895721042692, 10444.738881528023, 5602.579806514527, 5616.803411880564, 5626.43735626434, 5635.605507614428, 5664.461876121762, 4503.842365517191, 4966.801327946841, 5056.696598204119, 5058.873528161826, 5117.488251174927, 4064.6545043671617, 4068.4144256255304, 4118.402831589463, 4146.440230568895, 4159.9792001039805, 1265.8038004109378, 1334.9799753003713, 1337.2615599720518, 1341.9146904345073, 1366.9931650341684, 1396.2809153286066, 1421.2822524625205, 1430.4921752777614, 1438.6331485471137, 1453.1789538910482, 8355.0, 8505.0, 8509.829803404022, 8538.146185381536, 8550.1449855014, 518.1036806325079, 519.5090639345857, 520.1002266079703, 522.9058769421465, 530.9177077552986, 5437.619366644376, 6304.0, 6373.71318290678, 6391.520635952322, 6397.872042559123, 10739.409332486788, 11068.944655276671, 11171.385573793357, 11252.49363778632, 11259.437028148724, 10577.31247468912, 10884.23810333285, 10979.945100274448, 11055.336679799077, 11085.556577736801, 8483.872741908875, 8499.74500764978, 8538.658453661908, 8683.696070637623, 8721.476711397336, 8025.317847982987, 8137.79655508617, 8190.754277371689, 8230.588470576327, 8333.208345207195, 9451.0, 9770.511474426392, 9788.412695238309, 9799.951000244953, 9879.555420005972, 9961.800763984535, 10096.242781791541, 10135.442550659785, 10150.0, 10158.746031349276, 7546.962265188639, 7554.395648348009, 7607.809804754704, 7611.695532178651, 7694.923050769421, 8311.0, 8338.958305208678, 8339.041010283894, 8350.498970061573, 8355.540445275568, 7472.514286571355, 7697.730579429693, 7728.304452599293, 7764.650590723544, 7785.727499537489, 5903.704814759159, 7427.851442971219, 7445.181030086795, 7580.9620951894885, 7668.424868134801, 7878.172791857001, 8036.87944680842, 8075.636596353061, 8095.878561821695, 8110.878336825071, 7213.71145154188, 7271.636418178964, 7281.526700764433, 7306.926930730838, 7342.155652099863, 7300.379467745302, 7315.122185337794, 7323.450741194538, 7359.77920662381, 7393.852122957618], "unit": "score", "name": "mootools.html", "value": 4989.493240737242}, {"lowerIsBetter": false, "replicates": [332.7952810824814, 336.8770398804437, 340.7699802633225, 342.6316709537247, 347.9251960828423, 6639.302873198317, 6640.9374500079875, 6677.565958212713, 6677.833054173642, 6707.966460167704, 6611.438027767634, 6669.266380698119, 6671.866562668756, 6676.866462670744, 6685.43173830225, 4684.812607495714, 4804.783784729696, 4891.8777030574165, 4895.828645997391, 4942.233953737167, 3905.648491635752, 4847.563719265266, 4866.440359358666, 4880.0, 4882.974575339165, 4813.951860481386, 4824.903501929959, 4829.806807727687, 4831.299461578069, 4854.247591623286, 4846.0550192712435, 4846.68496547725, 4848.660593758421, 4860.562549370538, 4879.097366987119, 4200.894977625553, 4208.200441916057, 4216.093539888908, 4221.451211342536, 4226.809793559297, 6227.011807627877, 6270.6864656766975, 6409.262934762469, 6417.422431981144, 6461.418472337512, 5425.860569280456, 5445.83662490126, 5862.179294898718, 5883.146943693183, 5904.291485021782, 7139.82150446243, 7144.964275178643, 7163.928360716378, 7183.712651493986, 7188.604626745527, 4721.716696998191, 4731.195696731564, 4744.217204161309, 4744.525547445228, 4760.119377915063, 7571.924280757177, 7584.696612135508, 7593.164751877289, 7593.240675932418, 7603.733869314603, 3791.2227993261317, 4466.151431228056, 4657.883552911204, 4810.975945120322, 4814.687045342112, 4666.113438446752, 4722.031983443386, 4724.362211101526, 4729.763511824395, 4757.976210118927, 5007.47421520735, 5628.465295796893, 5656.745446454919, 5659.066254068115, 5664.178694089416, 6650.53446258767, 7150.284971502912, 7159.534630249122, 7164.21193668696, 7191.748288809867, 1609.6861112083266, 1633.8529532342147, 1634.3462614953876, 1635.2641311409675, 1640.3930545697929, 1014.8731408573929, 1045.9529321180564, 1052.9789404211872, 1057.2757661002238, 1065.5258410007627, 6630.403263706193, 6676.0, 6705.966470167618, 6719.227288861745, 6721.630310332881, 7428.962855185798, 7432.814179645552, 7433.888491672629, 7436.702531898772, 7472.962635186898, 6496.447801936793, 6564.343565643398, 6765.594064356154, 6803.455723542104, 6841.965790171117, 3932.075962148893, 3979.781112038808, 3981.303271927401, 3990.082281075369, 3997.9400308995387, 7911.564863932539, 7916.683332666744, 7917.920820791718, 7928.1675424080795, 7936.642851071716, 7429.405647548183, 7754.806129846799, 7775.650095745592, 7810.29707326332, 7825.686972521149, 6607.405333520006, 7796.337311328487, 7817.960910195527, 7835.059792824897, 7878.212178782191, 7096.822579435349, 7515.361194298327, 7531.3598344141365, 7539.736109236151, 7558.0, 6000.849978750566, 7376.668049937873, 7382.2617738225745, 7383.520071195355, 7437.776866694008, 7579.886301705368, 7838.64726087316, 7910.367170626451, 7918.564478953713, 7925.0886148093705, 4660.254359302496, 4666.973265881501, 4705.529447055267, 4720.339152518719, 4736.834210802605, 7458.291462311072, 7459.701611935679, 7464.477486575887, 7498.437617178624, 7526.360259377795, 5836.824895253149, 7217.6030318333, 7236.674349654173, 7241.203467618663, 7276.199618042117, 7025.437964962688, 7095.432365410858, 7207.9279207207255, 7217.170025447141, 7264.709411623688, 6185.597936134137, 6363.745450182126, 7047.436205103682, 7047.577145371294, 7082.114735658043, 5225.869353266199, 6592.373724496165, 7240.674169662272, 7256.854862902818, 7263.273672632906, 5881.441263080001, 6193.009118541192, 7061.576305421691, 7064.964675176591, 7106.0], "unit": "score", "name": "prototype.html", "value": 5202.501025056294}, {"lowerIsBetter": false, "replicates": [669.334012657406, 701.1586096683978, 764.121260550367, 778.8247644280037, 784.6861255497801, 12140.392980350991, 14855.480058197965, 15216.77174842377, 15256.466023689172, 15394.846051539482, 11520.827187592193, 11522.308661480318, 14105.0, 14106.224157671324, 14127.646808829784, 761.7143571160815, 957.7270477913761, 957.8563215517676, 970.277143528069, 970.6020531582053, 913.3332667152982, 926.5135803703076, 931.4225180388135, 934.2059249637822, 942.575840871607, 992.8659630949837, 1039.9964034706506, 1042.2079219792936, 1042.9947850260776, 1048.6067724603274, 1002.3735165521549, 1023.2785885950424, 1024.7643042100358, 1028.7273872423814, 1033.013472134114, 782.953022818627, 787.5078076202374, 789.1004255149135, 789.3409003482042, 791.5962858941923, 12071.456784444721, 15119.319630616648, 15226.46707365248, 15231.162286074261, 15290.082595044332, 12685.93657031709, 12939.158954667917, 13027.934860325733, 13076.476940922352, 13132.212067275994, 10073.0, 10169.186465082776, 10265.076143147078, 10546.736331591772, 10633.096186824128, 3523.119220194951, 3556.3242983833247, 3586.246888153491, 3648.7445878788494, 3819.8472061117523, 82375.0, 82973.58513207456, 83457.58271208666, 84950.72573911396, 85153.57423212906, 9577.569009394594, 9689.40124879387, 9720.805583888425, 9847.261455390875, 9945.502724863727, 21861.906904654705, 22130.336089917328, 22217.22239721602, 22948.311550653507, 22997.08011679514, 7534.35957943581, 7649.617519124133, 7799.220077992269, 7881.330086942674, 7918.0, 3542.7600339880837, 3874.8837534874, 4004.3593025115842, 4013.2374848779223, 4078.979605102015, 3107.9689203107678, 3579.856805727794, 3615.457681347766, 3655.2324011957253, 3661.5606127264364, 656.2617055812211, 668.5420486966443, 672.5561129654404, 677.5054210426416, 682.7712716240115, 590.5187272373003, 591.2668291318734, 592.4253474130087, 602.1870474858993, 612.8784324685814, 7942.205779422012, 7970.322522585529, 8022.318102961313, 8236.176382361717, 8266.669333226724, 475.60524764445427, 492.97042177469467, 578.6159783217121, 580.6022874331097, 606.8118883146238, 3599.880501892064, 3805.980970095132, 3812.0, 3864.1885204107452, 3891.7081218908697, 90388.0, 96203.0, 97879.021209787, 99237.5114373285, 99523.01430957083, 76687.61656191683, 77910.61044694741, 78218.0, 78672.60663696645, 79766.20233797704, 71157.2884271161, 71721.2827871725, 72285.2771472289, 72394.0, 72398.0, 7626.733064342721, 7791.883121753292, 7876.566788826441, 7954.965854438886, 8087.393445491494, 48372.06511739632, 49880.0, 50548.74725626349, 51376.0, 51618.22572661488, 56786.71606642105, 68515.28711782246, 70303.64848175932, 71210.64394677994, 73187.26812731805, 9823.557939892578, 9931.404115753077, 10171.898281017391, 10229.693109206735, 10756.677299681021, 10658.573657053632, 10701.732456688645, 10802.459877006275, 11001.504932277907, 11609.419529023346, 10143.137833284254, 10202.38785672862, 10310.536025879004, 10365.481725913523, 10677.359358438518, 10120.59517619287, 10182.185425166117, 10248.805732484196, 10303.433311167957, 10524.736881577715, 10207.54066067014, 10227.43749093807, 10814.405207713651, 10817.729556761144, 11004.889951100708, 8729.47623142588, 8984.0, 8987.505687187268, 9002.0, 9116.498592577473, 8612.65549378018, 8994.460332380078, 8995.730128096167, 9026.819463610822, 9041.68354107603], "unit": "score", "name": "yui.html", "value": 6877.648712440605}], "name": "dromaeo_css", "value": 7614.526202943301}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 113.0, 117.0, 116.0, 117.0, 128.0, 114.0, 114.0, 114.0, 115.0], "unit": "score", "name": "ai-astar", "value": 116.4}, {"lowerIsBetter": true, "replicates": [147.0, 120.0, 145.0, 148.0, 119.0, 175.0, 155.0, 150.0, 147.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 142.5}, {"lowerIsBetter": true, "replicates": [195.0, 197.0, 192.0, 205.0, 200.0, 198.0, 199.0, 194.0, 193.0, 284.0], "unit": "score", "name": "audio-dft", "value": 205.7}, {"lowerIsBetter": true, "replicates": [67.0, 71.0, 69.0, 104.0, 52.0, 57.0, 58.0, 60.0, 120.0, 56.0], "unit": "score", "name": "audio-fft", "value": 71.4}, {"lowerIsBetter": true, "replicates": [82.0, 78.0, 123.0, 95.0, 117.0, 71.0, 102.0, 82.0, 98.0, 152.0], "unit": "score", "name": "audio-oscillator", "value": 100.0}, {"lowerIsBetter": true, "replicates": [91.0, 87.0, 78.0, 129.0, 94.0, 86.0, 111.0, 87.0, 136.0, 130.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 102.9}, {"lowerIsBetter": true, "replicates": [150.0, 149.0, 108.0, 149.0, 90.0, 98.0, 143.0, 149.0, 117.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 130.1}, {"lowerIsBetter": true, "replicates": [90.0, 91.0, 89.0, 89.0, 90.0, 96.0, 90.0, 90.0, 90.0, 88.0], "unit": "score", "name": "imaging-desaturate", "value": 90.3}, {"lowerIsBetter": true, "replicates": [58.0, 62.0, 61.0, 58.0, 61.0, 60.0, 61.0, 69.0, 87.0, 41.0], "unit": "score", "name": "json-parse-financial", "value": 61.8}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 68.0, 68.0, 71.0, 72.0, 66.0, 67.0, 57.0, 74.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.8}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 81.0, 84.0, 101.0, 108.0, 109.0, 108.0, 82.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 92.4}, {"lowerIsBetter": true, "replicates": [120.0, 120.0, 124.0, 123.0, 124.0, 135.0, 134.0, 113.0, 120.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.6}, {"lowerIsBetter": true, "replicates": [118.0, 179.0, 122.0, 167.0, 171.0, 175.0, 165.0, 131.0, 138.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.3}, {"lowerIsBetter": true, "replicates": [64.0, 68.0, 67.0, 66.0, 68.0, 67.0, 64.0, 66.0, 67.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.1}], "name": "kraken", "value": 1520.2999999999997}]} 05:27:09 INFO - Return code: 0 05:27:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:27:09 ERROR - # TBPL SUCCESS # 05:27:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:27:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:27:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:27:09 INFO - 2016-04-07 05:27:09.093 screenresolution[1683:10325] starting screenresolution argv=screenresolution get 05:27:09 INFO - 2016-04-07 05:27:09.095 screenresolution[1683:10325] Display 0: 1600x1200x32@60 05:27:09 INFO - 2016-04-07 05:27:09.101 screenresolution[1684:10329] starting screenresolution argv=screenresolution list 05:27:09 INFO - Available Modes on Display 0 05:27:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:27:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:27:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:27:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:27:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:27:09 INFO - Intel Iris: 05:27:09 INFO - Chipset Model: Intel Iris 05:27:09 INFO - Type: GPU 05:27:09 INFO - Bus: Built-In 05:27:09 INFO - VRAM (Dynamic, Max): 1536 MB 05:27:09 INFO - Vendor: Intel (0x8086) 05:27:09 INFO - Device ID: 0x0a2e 05:27:09 INFO - Revision ID: 0x0009 05:27:09 INFO - Displays: 05:27:09 INFO - Display: 05:27:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:27:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:27:09 INFO - Display Serial Number: 1600x1200 60 05:27:09 INFO - Main Display: Yes 05:27:09 INFO - Mirror: Off 05:27:09 INFO - Online: Yes 05:27:09 INFO - Rotation: Supported 05:27:09 INFO - Return code: 0 05:27:09 INFO - Running post-action listener: _resource_record_post_action 05:27:09 INFO - Running post-run listener: _resource_record_post_run 05:27:10 INFO - Total resource usage - Wall time: 1202s; CPU: 53.0%; Read bytes: 37795328; Write bytes: 666119168; Read time: 397; Write time: 1870 05:27:10 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 360745472; Write bytes: 354306048; Read time: 28141; Write time: 686 05:27:10 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 35812864; Write bytes: 301683712; Read time: 371; Write time: 1151 05:27:10 INFO - Running post-run listener: _upload_blobber_files 05:27:10 INFO - Blob upload gear active. 05:27:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:27:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:27:10 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:27:10 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:27:10 INFO - (blobuploader) - INFO - Open directory for files ... 05:27:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:27:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:27:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:12 INFO - (blobuploader) - INFO - Done attempting. 05:27:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:27:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:27:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:13 INFO - (blobuploader) - INFO - Done attempting. 05:27:13 INFO - (blobuploader) - INFO - Iteration through files over. 05:27:13 INFO - Return code: 0 05:27:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:27:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:27:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be3693afd7d20aada888b9ab4c6c3e521de41e84c7d6a0f9b771d2331371dc956b142efaa138bce8f10176f61b30c232886bcc972356860094a1fed6c0022632", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b9635bcf5d855538e378d869ca20aea1bd2326c0c2bc0019e483f27b7f9371bf912355be171c4747df066bdfa9e60a2d1a751a6ca61e53068b6b01af10ba72c8"} 05:27:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:27:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:27:13 INFO - Contents: 05:27:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be3693afd7d20aada888b9ab4c6c3e521de41e84c7d6a0f9b771d2331371dc956b142efaa138bce8f10176f61b30c232886bcc972356860094a1fed6c0022632", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b9635bcf5d855538e378d869ca20aea1bd2326c0c2bc0019e483f27b7f9371bf912355be171c4747df066bdfa9e60a2d1a751a6ca61e53068b6b01af10ba72c8"} 05:27:13 INFO - Running post-run listener: copy_logs_to_upload_dir 05:27:13 INFO - Copying logs to upload dir... 05:27:13 INFO - mkdir: /builds/slave/test/build/upload/logs 05:27:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.806793 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-04-07 05:27:13.142232) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 05:27:13.145331) ========= 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.GKb1OMr0Xu/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.tRbloqndPR/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be3693afd7d20aada888b9ab4c6c3e521de41e84c7d6a0f9b771d2331371dc956b142efaa138bce8f10176f61b30c232886bcc972356860094a1fed6c0022632", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b9635bcf5d855538e378d869ca20aea1bd2326c0c2bc0019e483f27b7f9371bf912355be171c4747df066bdfa9e60a2d1a751a6ca61e53068b6b01af10ba72c8"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011128 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be3693afd7d20aada888b9ab4c6c3e521de41e84c7d6a0f9b771d2331371dc956b142efaa138bce8f10176f61b30c232886bcc972356860094a1fed6c0022632", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b9635bcf5d855538e378d869ca20aea1bd2326c0c2bc0019e483f27b7f9371bf912355be171c4747df066bdfa9e60a2d1a751a6ca61e53068b6b01af10ba72c8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 05:27:13.172978) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:27:13.173303) ========= 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.GKb1OMr0Xu/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.tRbloqndPR/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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.005122 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:27:13.221780) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 05:27:13.222101) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 05:27:13.222505) ========= ========= Total master_lag: 0.24 =========