builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0012 starttime: 1457871906.86 results: success (0) buildid: 20160313030418 builduid: d9ebc242af5646c383ecf644bcec4b07 revision: d1d47ba19ce9d46222030d491f9fe28dbf80be12 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-13 05:25:06.855678) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-13 05:25:06.856188) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-13 05:25:06.856547) ========= 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.ndQtWxRqSY/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.k4Fb4cjy0J/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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.005496 basedir: '/builds/slave/test' ========= master_lag: 0.09 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-13 05:25:06.948901) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-13 05:25:06.949383) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-13 05:25:07.134409) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 05:25:07.134735) ========= 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.ndQtWxRqSY/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.k4Fb4cjy0J/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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.005424 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 05:25:07.227482) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-13 05:25:07.227895) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-13 05:25:07.228370) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 05:25:07.228702) ========= 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.ndQtWxRqSY/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.k4Fb4cjy0J/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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-03-13 05:25:07-- 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% 41.1M=0s 2016-03-13 05:25:07 (41.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.537077 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 05:25:07.834921) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 05:25:07.835283) ========= 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.ndQtWxRqSY/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.k4Fb4cjy0J/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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.026220 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 05:25:07.913062) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-13 05:25:07.913469) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d1d47ba19ce9d46222030d491f9fe28dbf80be12 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d1d47ba19ce9d46222030d491f9fe28dbf80be12 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ndQtWxRqSY/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.k4Fb4cjy0J/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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-03-13 05:25:07,987 truncating revision to first 12 chars 2016-03-13 05:25:07,987 Setting DEBUG logging. 2016-03-13 05:25:07,987 attempt 1/10 2016-03-13 05:25:07,987 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d1d47ba19ce9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-13 05:25:08,931 unpacking tar archive at: mozilla-central-d1d47ba19ce9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.189144 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-13 05:25:09.127461) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-13 05:25:09.127913) ========= echo d1d47ba19ce9d46222030d491f9fe28dbf80be12 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd1d47ba19ce9d46222030d491f9fe28dbf80be12'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ndQtWxRqSY/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.k4Fb4cjy0J/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 d1d47ba19ce9d46222030d491f9fe28dbf80be12 program finished with exit code 0 elapsedTime=0.005296 script_repo_revision: 'd1d47ba19ce9d46222030d491f9fe28dbf80be12' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-13 05:25:09.178352) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-13 05:25:09.178746) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-13 05:25:09.193659) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 21 secs) (at 2016-03-13 05:25:09.194170) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ndQtWxRqSY/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.k4Fb4cjy0J/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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:25:09 INFO - MultiFileLogger online at 20160313 05:25:09 in /builds/slave/test 05:25:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:25:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:25:09 INFO - {'append_to_log': False, 05:25:09 INFO - 'base_work_dir': '/builds/slave/test', 05:25:09 INFO - 'blob_upload_branch': 'Firefox', 05:25:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:25:09 INFO - 'branch': 'Firefox', 05:25:09 INFO - 'buildbot_json_path': 'buildprops.json', 05:25:09 INFO - 'config_files': ('talos/mac_config.py',), 05:25:09 INFO - 'default_actions': ('clobber', 05:25:09 INFO - 'read-buildbot-config', 05:25:09 INFO - 'download-and-extract', 05:25:09 INFO - 'populate-webroot', 05:25:09 INFO - 'create-virtualenv', 05:25:09 INFO - 'install', 05:25:09 INFO - 'run-tests'), 05:25:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:25:09 INFO - 'download_minidump_stackwalk': True, 05:25:09 INFO - 'download_symbols': 'ondemand', 05:25:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:25:09 INFO - 'tooltool.py': '/tools/tooltool.py', 05:25:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:25:09 INFO - '/tools/misc-python/virtualenv.py')}, 05:25:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:25:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:25:09 INFO - 'installer_path': 'installer.exe', 05:25:09 INFO - 'log_level': 'info', 05:25:09 INFO - 'log_name': 'talos', 05:25:09 INFO - 'log_to_console': True, 05:25:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:25:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:25:09 INFO - 'opt_config_files': (), 05:25:09 INFO - 'pip_index': False, 05:25:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:25:09 INFO - 'cmd': ('bash', 05:25:09 INFO - '-c', 05:25:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:25:09 INFO - 'enabled': True, 05:25:09 INFO - 'halt_on_failure': False, 05:25:09 INFO - 'name': 'check_screen_resolution'},), 05:25:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:25:09 INFO - 'cmd': ('bash', 05:25:09 INFO - '-c', 05:25:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:25:09 INFO - 'enabled': True, 05:25:09 INFO - 'halt_on_failure': False, 05:25:09 INFO - 'name': 'check_screen_resolution'},), 05:25:09 INFO - 'run_cmd_checks_enabled': True, 05:25:09 INFO - 'sps_profile': False, 05:25:09 INFO - 'sps_profile_interval': 0, 05:25:09 INFO - 'suite': 'dromaeojs-e10s', 05:25:09 INFO - 'system_bits': '32', 05:25:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:25:09 INFO - 'title': 't-yosemite-r7-0012', 05:25:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:25:09 INFO - 'use_talos_json': True, 05:25:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:25:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:25:09 INFO - 'work_dir': 'build'} 05:25:09 INFO - ##### 05:25:09 INFO - ##### Running clobber step. 05:25:09 INFO - ##### 05:25:09 INFO - Running pre-action listener: _resource_record_pre_action 05:25:09 INFO - Running main action method: clobber 05:25:09 INFO - rmtree: /builds/slave/test/build 05:25:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:25:10 INFO - Running post-action listener: _resource_record_post_action 05:25:10 INFO - ##### 05:25:10 INFO - ##### Running read-buildbot-config step. 05:25:10 INFO - ##### 05:25:10 INFO - Running pre-action listener: _resource_record_pre_action 05:25:10 INFO - Running main action method: read_buildbot_config 05:25:10 INFO - Using buildbot properties: 05:25:10 INFO - { 05:25:10 INFO - "project": "", 05:25:10 INFO - "product": "firefox", 05:25:10 INFO - "script_repo_revision": "production", 05:25:10 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:25:10 INFO - "repository": "", 05:25:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:25:10 INFO - "buildid": "20160313030418", 05:25:10 INFO - "stage_platform": "macosx64", 05:25:10 INFO - "basedir": "/builds/slave/test", 05:25:10 INFO - "nightly_build": "True", 05:25:10 INFO - "buildnumber": 138, 05:25:10 INFO - "slavename": "t-yosemite-r7-0012", 05:25:10 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:25:10 INFO - "platform": "yosemite_r7", 05:25:10 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:25:10 INFO - "branch": "mozilla-central", 05:25:10 INFO - "repo_path": "mozilla-central", 05:25:10 INFO - "revision": "d1d47ba19ce9d46222030d491f9fe28dbf80be12", 05:25:10 INFO - "pgo_build": "False", 05:25:10 INFO - "builduid": "d9ebc242af5646c383ecf644bcec4b07", 05:25:10 INFO - "slavebuilddir": "test" 05:25:10 INFO - } 05:25:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:25:10 INFO - Running post-action listener: _resource_record_post_action 05:25:10 INFO - ##### 05:25:10 INFO - ##### Running download-and-extract step. 05:25:10 INFO - ##### 05:25:10 INFO - Running pre-action listener: _resource_record_pre_action 05:25:10 INFO - Running main action method: download_and_extract 05:25:10 INFO - mkdir: /builds/slave/test/build/tests 05:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:10 INFO - https://queue.taskcluster.net/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:25:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:25:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:25:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:25:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 05:25:41 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json: timed out 05:25:41 INFO - retry: attempt #1 caught exception: timed out 05:25:41 INFO - retry: Failed, sleeping 30 seconds before retrying 05:26:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #2 05:26:26 INFO - Downloaded 1199 bytes. 05:26:26 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:26:26 INFO - Using the following test package requirements: 05:26:26 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:26:26 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:26:26 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:26:26 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:26:26 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:26:26 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:26:26 INFO - u'jsshell-mac.zip'], 05:26:26 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:26:26 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:26:26 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:26:26 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:26:26 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:26:26 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:26:26 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:26:26 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:26:26 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:26:26 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:26:26 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:26:26 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:26: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:26:26 INFO - https://queue.taskcluster.net/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:26:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:26:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:26:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:26:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:26:30 INFO - Downloaded 17843022 bytes. 05:26:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:26:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:26:33 INFO - Return code: 0 05:26:33 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:26:33 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:26:33 INFO - https://queue.taskcluster.net/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:26:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:26:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:26:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:26:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:26:34 INFO - Downloaded 17843022 bytes. 05:26:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:26:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:26:37 INFO - Return code: 0 05:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:37 INFO - https://queue.taskcluster.net/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:26:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:26:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:26:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:26:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:26:38 INFO - Downloaded 10845263 bytes. 05:26:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:26:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:26:38 INFO - Return code: 0 05:26:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:38 INFO - https://queue.taskcluster.net/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:26:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:26:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:26:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:26:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 05:26:44 INFO - Downloaded 111224134 bytes. 05:26:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:26:44 INFO - mkdir: /builds/slave/test/properties 05:26:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:26:44 INFO - Writing to file /builds/slave/test/properties/build_url 05:26:44 INFO - Contents: 05:26:44 INFO - build_url:https://queue.taskcluster.net/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:26:45 INFO - Running post-action listener: _resource_record_post_action 05:26:45 INFO - Running post-action listener: set_extra_try_arguments 05:26:45 INFO - ##### 05:26:45 INFO - ##### Running populate-webroot step. 05:26:45 INFO - ##### 05:26:45 INFO - Running pre-action listener: _resource_record_pre_action 05:26:45 INFO - Running main action method: populate_webroot 05:26:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:26:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:26:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:26:45 INFO - '--tppagecycles', 05:26:45 INFO - '7'], 05:26:45 INFO - 'tests': ['tsvgm']}}, 05:26:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:26:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:26:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:26:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:26:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:26:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:26:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:26:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:45 INFO - 'talos_options': ['--e10s'], 05:26:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:26:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:45 INFO - 'tests': ['damp', 'tps']}, 05:26:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:45 INFO - 'talos_options': ['--e10s'], 05:26:45 INFO - 'tests': ['damp', 'tps']}, 05:26:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:26:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:26:45 INFO - 'other': {'tests': ['a11yr', 05:26:45 INFO - 'ts_paint', 05:26:45 INFO - 'tpaint', 05:26:45 INFO - 'sessionrestore', 05:26:45 INFO - 'sessionrestore_no_auto_restore', 05:26:45 INFO - 'tabpaint']}, 05:26:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:26:45 INFO - 'tests': ['a11yr', 05:26:45 INFO - 'ts_paint', 05:26:45 INFO - 'tpaint', 05:26:45 INFO - 'sessionrestore', 05:26:45 INFO - 'sessionrestore_no_auto_restore', 05:26:45 INFO - 'tabpaint']}, 05:26:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:26:45 INFO - 'tests': ['a11yr', 05:26:45 INFO - 'ts_paint', 05:26:45 INFO - 'tpaint', 05:26:45 INFO - 'sessionrestore', 05:26:45 INFO - 'sessionrestore_no_auto_restore', 05:26:45 INFO - 'tabpaint']}, 05:26:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:26:45 INFO - 'tests': ['a11yr', 05:26:45 INFO - 'ts_paint', 05:26:45 INFO - 'tpaint', 05:26:45 INFO - 'sessionrestore', 05:26:45 INFO - 'sessionrestore_no_auto_restore', 05:26:45 INFO - 'tabpaint']}, 05:26:45 INFO - 'other_l64': {'tests': ['a11yr', 05:26:45 INFO - 'ts_paint', 05:26:45 INFO - 'tpaint', 05:26:45 INFO - 'sessionrestore', 05:26:45 INFO - 'sessionrestore_no_auto_restore', 05:26:45 INFO - 'tabpaint']}, 05:26:45 INFO - 'other_nol64': {'tests': ['a11yr', 05:26:45 INFO - 'ts_paint', 05:26:45 INFO - 'tpaint', 05:26:45 INFO - 'sessionrestore', 05:26:45 INFO - 'sessionrestore_no_auto_restore', 05:26:45 INFO - 'tabpaint']}, 05:26:45 INFO - 'svgr': {'tests': ['tsvgx', 05:26:45 INFO - 'tsvgr_opacity', 05:26:45 INFO - 'tart', 05:26:45 INFO - 'tscrollx', 05:26:45 INFO - 'cart']}, 05:26:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:26:45 INFO - 'tests': ['tsvgx', 05:26:45 INFO - 'tsvgr_opacity', 05:26:45 INFO - 'tart', 05:26:45 INFO - 'tscrollx', 05:26:45 INFO - 'cart']}, 05:26:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:45 INFO - 'tests': ['tp5o']}, 05:26:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:45 INFO - 'talos_options': ['--e10s'], 05:26:45 INFO - 'tests': ['tp5o']}, 05:26:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:45 INFO - 'talos_options': ['--xperf_path', 05:26:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:26:45 INFO - 'tests': ['tp5n']}, 05:26:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:45 INFO - 'talos_options': ['--e10s', 05:26:45 INFO - '--xperf_path', 05:26:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:26:45 INFO - 'tests': ['tp5n']}}, 05:26:45 INFO - 'talos.zip': {'path': '', 05:26:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:26:45 INFO - Running post-action listener: _resource_record_post_action 05:26:45 INFO - ##### 05:26:45 INFO - ##### Running create-virtualenv step. 05:26:45 INFO - ##### 05:26:45 INFO - Running pre-action listener: _resource_record_pre_action 05:26:45 INFO - Running main action method: create_virtualenv 05:26:45 INFO - Creating virtualenv /builds/slave/test/build/venv 05:26:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:26:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:26:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:26:45 INFO - Using real prefix '/tools/python27' 05:26:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:26:46 INFO - Installing distribute.............................................................................................................................................................................................done. 05:26:49 INFO - Installing pip.................done. 05:26:49 INFO - Return code: 0 05:26:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7c847cb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db94d30>, '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 0x10d9b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db8bb20>, '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.ndQtWxRqSY/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.k4Fb4cjy0J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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:26:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:26:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:26:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ndQtWxRqSY/Render', 05:26:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:49 INFO - 'HOME': '/Users/cltbld', 05:26:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:49 INFO - 'LOGNAME': 'cltbld', 05:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:49 INFO - 'MOZ_NO_REMOTE': '1', 05:26:49 INFO - 'NO_EM_RESTART': '1', 05:26:49 INFO - 'PAGER': '/bin/cat', 05:26:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:49 INFO - 'PWD': '/builds/slave/test', 05:26:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:49 INFO - 'SHELL': '/bin/bash', 05:26:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k4Fb4cjy0J/Listeners', 05:26:49 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 05:26:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:49 INFO - 'USER': 'cltbld', 05:26:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:49 INFO - 'XPC_FLAGS': '0x0', 05:26:49 INFO - 'XPC_SERVICE_NAME': '0', 05:26:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:26:49 INFO - Cleaning up... 05:26:49 INFO - Return code: 0 05:26:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7c847cb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db94d30>, '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 0x10d9b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db8bb20>, '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.ndQtWxRqSY/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.k4Fb4cjy0J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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:26:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:26:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:26:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ndQtWxRqSY/Render', 05:26:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:49 INFO - 'HOME': '/Users/cltbld', 05:26:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:49 INFO - 'LOGNAME': 'cltbld', 05:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:49 INFO - 'MOZ_NO_REMOTE': '1', 05:26:49 INFO - 'NO_EM_RESTART': '1', 05:26:49 INFO - 'PAGER': '/bin/cat', 05:26:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:49 INFO - 'PWD': '/builds/slave/test', 05:26:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:49 INFO - 'SHELL': '/bin/bash', 05:26:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k4Fb4cjy0J/Listeners', 05:26:49 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 05:26:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:49 INFO - 'USER': 'cltbld', 05:26:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:49 INFO - 'XPC_FLAGS': '0x0', 05:26:49 INFO - 'XPC_SERVICE_NAME': '0', 05:26:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:49 INFO - Downloading/unpacking psutil>=0.7.1 05:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:26:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:26:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:26:52 INFO - Installing collected packages: psutil 05:26:52 INFO - Running setup.py install for psutil 05:26:52 INFO - building 'psutil._psutil_osx' extension 05:26:52 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:26:52 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:26:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:26:53 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:26:53 INFO - building 'psutil._psutil_posix' extension 05:26:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:26:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:26:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:26:53 INFO - ^ 05:26:53 INFO - 1 warning generated. 05:26:53 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:26:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:26:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:26:53 INFO - Successfully installed psutil 05:26:53 INFO - Cleaning up... 05:26:53 INFO - Return code: 0 05:26:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:26: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:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26: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:26:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7c847cb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db94d30>, '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 0x10d9b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db8bb20>, '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.ndQtWxRqSY/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.k4Fb4cjy0J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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:26:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:26:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:26:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ndQtWxRqSY/Render', 05:26:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:53 INFO - 'HOME': '/Users/cltbld', 05:26:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:53 INFO - 'LOGNAME': 'cltbld', 05:26:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:53 INFO - 'MOZ_NO_REMOTE': '1', 05:26:53 INFO - 'NO_EM_RESTART': '1', 05:26:53 INFO - 'PAGER': '/bin/cat', 05:26:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:53 INFO - 'PWD': '/builds/slave/test', 05:26:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:53 INFO - 'SHELL': '/bin/bash', 05:26:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k4Fb4cjy0J/Listeners', 05:26:53 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 05:26:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:53 INFO - 'USER': 'cltbld', 05:26:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:53 INFO - 'XPC_FLAGS': '0x0', 05:26:53 INFO - 'XPC_SERVICE_NAME': '0', 05:26:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:26:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:26:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:26:56 INFO - Installing collected packages: mozsystemmonitor 05:26:56 INFO - Running setup.py install for mozsystemmonitor 05:26:56 INFO - Successfully installed mozsystemmonitor 05:26:56 INFO - Cleaning up... 05:26:56 INFO - Return code: 0 05:26:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7c847cb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db94d30>, '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 0x10d9b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db8bb20>, '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.ndQtWxRqSY/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.k4Fb4cjy0J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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:26:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:26:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:26:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ndQtWxRqSY/Render', 05:26:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:56 INFO - 'HOME': '/Users/cltbld', 05:26:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:56 INFO - 'LOGNAME': 'cltbld', 05:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:56 INFO - 'MOZ_NO_REMOTE': '1', 05:26:56 INFO - 'NO_EM_RESTART': '1', 05:26:56 INFO - 'PAGER': '/bin/cat', 05:26:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:56 INFO - 'PWD': '/builds/slave/test', 05:26:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:56 INFO - 'SHELL': '/bin/bash', 05:26:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k4Fb4cjy0J/Listeners', 05:26:56 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 05:26:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:56 INFO - 'USER': 'cltbld', 05:26:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:56 INFO - 'XPC_FLAGS': '0x0', 05:26:56 INFO - 'XPC_SERVICE_NAME': '0', 05:26:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:56 INFO - Downloading/unpacking blobuploader==1.2.4 05:26:56 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:26:56 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:26:56 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:26:56 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:26:56 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:26:56 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:26:59 INFO - Downloading blobuploader-1.2.4.tar.gz 05:26:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:26:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:26: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:26: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:26: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:26: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:26: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:26: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:26:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:26:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:26: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:26: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:26: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:26: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:26: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:26: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:27:00 INFO - Downloading docopt-0.6.1.tar.gz 05:27:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:27:00 INFO - Installing collected packages: blobuploader, requests, docopt 05:27:00 INFO - Running setup.py install for blobuploader 05:27:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:27:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:27:00 INFO - Running setup.py install for requests 05:27:00 INFO - Running setup.py install for docopt 05:27:01 INFO - Successfully installed blobuploader requests docopt 05:27:01 INFO - Cleaning up... 05:27:01 INFO - Return code: 0 05:27:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7c847cb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db94d30>, '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 0x10d9b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db8bb20>, '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.ndQtWxRqSY/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.k4Fb4cjy0J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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:27:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:27:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ndQtWxRqSY/Render', 05:27:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:01 INFO - 'HOME': '/Users/cltbld', 05:27:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:01 INFO - 'LOGNAME': 'cltbld', 05:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:01 INFO - 'MOZ_NO_REMOTE': '1', 05:27:01 INFO - 'NO_EM_RESTART': '1', 05:27:01 INFO - 'PAGER': '/bin/cat', 05:27:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:01 INFO - 'PWD': '/builds/slave/test', 05:27:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:01 INFO - 'SHELL': '/bin/bash', 05:27:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k4Fb4cjy0J/Listeners', 05:27:01 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 05:27:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:01 INFO - 'USER': 'cltbld', 05:27:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:01 INFO - 'XPC_FLAGS': '0x0', 05:27:01 INFO - 'XPC_SERVICE_NAME': '0', 05:27:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:27:01 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-sKvyy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:27:01 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-ZnIRdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:27:01 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-Y4GEPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:27:01 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-DUVPp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:27:01 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-YDqdkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:27:01 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-Mnt1Q8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:27:02 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-3zkl35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:27:02 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-f7J4ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:27:02 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-YX6rX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:27:02 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-BUFomP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:27:02 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-V6pgD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:27:02 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-cXaQbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:27:02 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-_6ONIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:27:02 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-HohWwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:02 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-qgXs0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:27:02 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-I6lg46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:27:03 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-wGC4PY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:27:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:27:03 INFO - Running setup.py install for manifestparser 05:27:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:27:03 INFO - Running setup.py install for mozcrash 05:27:03 INFO - Running setup.py install for mozdebug 05:27:03 INFO - Running setup.py install for mozdevice 05:27:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:27:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:27:03 INFO - Running setup.py install for mozfile 05:27:03 INFO - Running setup.py install for mozhttpd 05:27:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:27:04 INFO - Running setup.py install for mozinfo 05:27:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:27:04 INFO - Running setup.py install for mozInstall 05:27:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:27:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:27:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:27:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:27:04 INFO - Running setup.py install for mozleak 05:27:04 INFO - Running setup.py install for mozlog 05:27:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:27:04 INFO - Running setup.py install for moznetwork 05:27:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:27:04 INFO - Running setup.py install for mozprocess 05:27:04 INFO - Running setup.py install for mozprofile 05:27:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:27:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:27:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:27:05 INFO - Running setup.py install for mozrunner 05:27:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:27:05 INFO - Running setup.py install for mozscreenshot 05:27:05 INFO - Running setup.py install for moztest 05:27:05 INFO - Running setup.py install for mozversion 05:27:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:27:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:27:05 INFO - Cleaning up... 05:27:05 INFO - Return code: 0 05:27:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:05 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:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:05 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:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:05 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 0x10dcf0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7c847cb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db94d30>, '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 0x10d9b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db8bb20>, '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.ndQtWxRqSY/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.k4Fb4cjy0J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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:27:05 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:27:05 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:27:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ndQtWxRqSY/Render', 05:27:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:05 INFO - 'HOME': '/Users/cltbld', 05:27:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:05 INFO - 'LOGNAME': 'cltbld', 05:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:05 INFO - 'MOZ_NO_REMOTE': '1', 05:27:05 INFO - 'NO_EM_RESTART': '1', 05:27:05 INFO - 'PAGER': '/bin/cat', 05:27:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:05 INFO - 'PWD': '/builds/slave/test', 05:27:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:05 INFO - 'SHELL': '/bin/bash', 05:27:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k4Fb4cjy0J/Listeners', 05:27:05 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 05:27:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:05 INFO - 'USER': 'cltbld', 05:27:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:05 INFO - 'XPC_FLAGS': '0x0', 05:27:05 INFO - 'XPC_SERVICE_NAME': '0', 05:27:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:27:06 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-PraF90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:27:06 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-BSxJ7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:27:06 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-nY_rqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:27:06 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-GlAzAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:27:06 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-qEjxFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:27:06 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:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:27:06 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-YMxou9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:27:06 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:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:27:06 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-ggUpdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:27:06 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:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:27:06 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-7G7Rvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:27:06 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:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:27:06 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-fVIlgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:27:06 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:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:27:06 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-7OpOeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:27:07 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-AVgi8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:27:07 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-lTo02h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:27:07 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-l6hyRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:27:07 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-3hL4Oa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:27:07 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:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:07 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-MaZUrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:07 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:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:27:07 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-k038Ea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:27:07 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:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:27:07 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-UCEx_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:27:07 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:27:07 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:27:07 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:27:07 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:27:07 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:27:07 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:27:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:27:07 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:27:07 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:27:07 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:27:07 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:27:07 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:27:07 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:27:10 INFO - Downloading blessings-1.6.tar.gz 05:27:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:27:10 INFO - Installing collected packages: blessings 05:27:10 INFO - Running setup.py install for blessings 05:27:10 INFO - Successfully installed blessings 05:27:10 INFO - Cleaning up... 05:27:10 INFO - Return code: 0 05:27:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:27:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:27:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:27:10 INFO - Reading from file tmpfile_stdout 05:27:10 INFO - Current package versions: 05:27:10 INFO - blessings == 1.6 05:27:10 INFO - blobuploader == 1.2.4 05:27:10 INFO - docopt == 0.6.1 05:27:10 INFO - manifestparser == 1.1 05:27:10 INFO - mozInstall == 1.12 05:27:10 INFO - mozcrash == 0.17 05:27:10 INFO - mozdebug == 0.1 05:27:10 INFO - mozdevice == 0.48 05:27:10 INFO - mozfile == 1.2 05:27:10 INFO - mozhttpd == 0.7 05:27:10 INFO - mozinfo == 0.9 05:27:10 INFO - mozleak == 0.1 05:27:10 INFO - mozlog == 3.1 05:27:10 INFO - moznetwork == 0.27 05:27:10 INFO - mozprocess == 0.22 05:27:10 INFO - mozprofile == 0.28 05:27:10 INFO - mozrunner == 6.11 05:27:10 INFO - mozscreenshot == 0.1 05:27:10 INFO - mozsystemmonitor == 0.0 05:27:10 INFO - moztest == 0.7 05:27:10 INFO - mozversion == 1.4 05:27:10 INFO - psutil == 3.1.1 05:27:10 INFO - requests == 1.2.3 05:27:10 INFO - wsgiref == 0.1.2 05:27:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:10 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 0x10dcf0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7c847cb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db94d30>, '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 0x10d9b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db8bb20>, '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.ndQtWxRqSY/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.k4Fb4cjy0J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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:27:10 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:27:10 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:27:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ndQtWxRqSY/Render', 05:27:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:10 INFO - 'HOME': '/Users/cltbld', 05:27:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:10 INFO - 'LOGNAME': 'cltbld', 05:27:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:10 INFO - 'MOZ_NO_REMOTE': '1', 05:27:10 INFO - 'NO_EM_RESTART': '1', 05:27:10 INFO - 'PAGER': '/bin/cat', 05:27:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:10 INFO - 'PWD': '/builds/slave/test', 05:27:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:10 INFO - 'SHELL': '/bin/bash', 05:27:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k4Fb4cjy0J/Listeners', 05:27:10 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 05:27:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:10 INFO - 'USER': 'cltbld', 05:27:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:10 INFO - 'XPC_FLAGS': '0x0', 05:27:10 INFO - 'XPC_SERVICE_NAME': '0', 05:27:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:27:11 INFO - Cleaning up... 05:27:11 INFO - Return code: 0 05:27:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:27:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7c847cb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db94d30>, '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 0x10d9b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db8bb20>, '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.ndQtWxRqSY/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.k4Fb4cjy0J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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:27:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:27:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:27:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ndQtWxRqSY/Render', 05:27:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:11 INFO - 'HOME': '/Users/cltbld', 05:27:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:11 INFO - 'LOGNAME': 'cltbld', 05:27:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:11 INFO - 'MOZ_NO_REMOTE': '1', 05:27:11 INFO - 'NO_EM_RESTART': '1', 05:27:11 INFO - 'PAGER': '/bin/cat', 05:27:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:11 INFO - 'PWD': '/builds/slave/test', 05:27:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:11 INFO - 'SHELL': '/bin/bash', 05:27:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k4Fb4cjy0J/Listeners', 05:27:11 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 05:27:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:11 INFO - 'USER': 'cltbld', 05:27:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:11 INFO - 'XPC_FLAGS': '0x0', 05:27:11 INFO - 'XPC_SERVICE_NAME': '0', 05:27:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:11 INFO - Downloading/unpacking jsonschema 05:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:27:13 INFO - Downloading/unpacking functools32 (from jsonschema) 05:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:14 INFO - Downloading functools32-3.2.3-2.tar.gz 05:27:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:27:14 INFO - warning: no files found matching '*.txt' 05:27:14 INFO - no previously-included directories found matching 'build' 05:27:14 INFO - no previously-included directories found matching 'dist' 05:27:14 INFO - no previously-included directories found matching '.git*' 05:27:14 INFO - Installing collected packages: jsonschema, functools32 05:27:14 INFO - Running setup.py install for functools32 05:27:14 INFO - warning: no files found matching '*.txt' 05:27:14 INFO - no previously-included directories found matching 'build' 05:27:14 INFO - no previously-included directories found matching 'dist' 05:27:14 INFO - no previously-included directories found matching '.git*' 05:27:14 INFO - Successfully installed jsonschema functools32 05:27:14 INFO - Cleaning up... 05:27:14 INFO - Return code: 0 05:27:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:27:14 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:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:14 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:27:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:14 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 0x10dcf0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcf74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7c847cb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db94d30>, '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 0x10d9b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db8bb20>, '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.ndQtWxRqSY/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.k4Fb4cjy0J/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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:27:14 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:27:14 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:27:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ndQtWxRqSY/Render', 05:27:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:14 INFO - 'HOME': '/Users/cltbld', 05:27:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:14 INFO - 'LOGNAME': 'cltbld', 05:27:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:14 INFO - 'MOZ_NO_REMOTE': '1', 05:27:14 INFO - 'NO_EM_RESTART': '1', 05:27:14 INFO - 'PAGER': '/bin/cat', 05:27:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:14 INFO - 'PWD': '/builds/slave/test', 05:27:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:14 INFO - 'SHELL': '/bin/bash', 05:27:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k4Fb4cjy0J/Listeners', 05:27:14 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 05:27:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:14 INFO - 'USER': 'cltbld', 05:27:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:14 INFO - 'XPC_FLAGS': '0x0', 05:27:14 INFO - 'XPC_SERVICE_NAME': '0', 05:27:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:14 INFO - Downloading/unpacking flake8 05:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:27:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:27:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:27:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:27:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:27:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:27:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:27:18 INFO - no previously-included directories found matching 'docs/_build' 05:27:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:27:18 INFO - Running setup.py install for pep8 05:27:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:27:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:27:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:27:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:27:18 INFO - no previously-included directories found matching 'docs/_build' 05:27:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:27:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:27:18 INFO - Cleaning up... 05:27:18 INFO - Return code: 0 05:27:18 INFO - Running post-action listener: _resource_record_post_action 05:27:18 INFO - Running post-action listener: _start_resource_monitoring 05:27:18 INFO - Starting resource monitoring. 05:27:18 INFO - ##### 05:27:18 INFO - ##### Running install step. 05:27:18 INFO - ##### 05:27:18 INFO - Running pre-action listener: _resource_record_pre_action 05:27:18 INFO - Running main action method: install 05:27:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:27:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:27:19 INFO - Reading from file tmpfile_stdout 05:27:19 INFO - Detecting whether we're running mozinstall >=1.0... 05:27:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:27:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:27:19 INFO - Reading from file tmpfile_stdout 05:27:19 INFO - Output received: 05:27:19 INFO - Usage: mozinstall [options] installer 05:27:19 INFO - Options: 05:27:19 INFO - -h, --help show this help message and exit 05:27:19 INFO - -d DEST, --destination=DEST 05:27:19 INFO - Directory to install application into. [default: 05:27:19 INFO - "/builds/slave/test"] 05:27:19 INFO - --app=APP Application being installed. [default: firefox] 05:27:19 INFO - mkdir: /builds/slave/test/build/application 05:27:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:27:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:27:53 INFO - Reading from file tmpfile_stdout 05:27:53 INFO - Output received: 05:27:53 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:27:53 INFO - Running post-action listener: _resource_record_post_action 05:27:53 INFO - ##### 05:27:53 INFO - ##### Running run-tests step. 05:27:53 INFO - ##### 05:27:53 INFO - Running pre-action listener: _resource_record_pre_action 05:27:53 INFO - Running main action method: run_tests 05:27:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:27:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:27:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:27:53 INFO - 2016-03-13 05:27:53.075 screenresolution[1651:7807] starting screenresolution argv=screenresolution get 05:27:53 INFO - 2016-03-13 05:27:53.077 screenresolution[1651:7807] Display 0: 1600x1200x32@60 05:27:53 INFO - 2016-03-13 05:27:53.083 screenresolution[1652:7810] starting screenresolution argv=screenresolution list 05:27:53 INFO - Available Modes on Display 0 05:27:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:27:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:27:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:27:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:27:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:27:53 INFO - Intel Iris: 05:27:53 INFO - Chipset Model: Intel Iris 05:27:53 INFO - Type: GPU 05:27:53 INFO - Bus: Built-In 05:27:53 INFO - VRAM (Dynamic, Max): 1536 MB 05:27:53 INFO - Vendor: Intel (0x8086) 05:27:53 INFO - Device ID: 0x0a2e 05:27:53 INFO - Revision ID: 0x0009 05:27:53 INFO - Displays: 05:27:53 INFO - Display: 05:27:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:27:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:27:53 INFO - Display Serial Number: 1600x1200 60 05:27:53 INFO - Main Display: Yes 05:27:53 INFO - Mirror: Off 05:27:53 INFO - Online: Yes 05:27:53 INFO - Rotation: Supported 05:27:53 INFO - Return code: 0 05:27:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:27:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:27:53 INFO - Python 2.7.3 05:27:53 INFO - Return code: 0 05:27:53 INFO - grabbing minidump binary from tooltool 05:27: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:27:53 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db94d30>, '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 0x10d9b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db8bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:27:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:27:53 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:27:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:27:53 INFO - Return code: 0 05:27:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:27:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:27:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:27:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:27:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:27:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:27:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:27:54 INFO - Return code: 0 05:27:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0012', '--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:27:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0012 --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:27:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ndQtWxRqSY/Render', 05:27:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:54 INFO - 'HOME': '/Users/cltbld', 05:27:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:54 INFO - 'LOGNAME': 'cltbld', 05:27:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:27:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:27:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:54 INFO - 'MOZ_NO_REMOTE': '1', 05:27:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:27:54 INFO - 'NO_EM_RESTART': '1', 05:27:54 INFO - 'PAGER': '/bin/cat', 05:27:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:54 INFO - 'PWD': '/builds/slave/test', 05:27:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:27:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:54 INFO - 'SHELL': '/bin/bash', 05:27:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k4Fb4cjy0J/Listeners', 05:27:54 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 05:27:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:54 INFO - 'USER': 'cltbld', 05:27:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:54 INFO - 'XPC_FLAGS': '0x0', 05:27:54 INFO - 'XPC_SERVICE_NAME': '0', 05:27:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0012', '--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:27:54 INFO - mozversion application_buildid: 20160313030418 05:27:54 INFO - mozversion application_changeset: d1d47ba19ce9d46222030d491f9fe28dbf80be12 05:27:54 INFO - mozversion application_display_name: Nightly 05:27:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:27:54 INFO - mozversion application_name: Firefox 05:27:54 INFO - mozversion application_remotingname: firefox 05:27:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:27:54 INFO - mozversion application_vendor: Mozilla 05:27:54 INFO - mozversion application_version: 48.0a1 05:27:54 INFO - mozversion platform_buildid: 20160313030418 05:27:54 INFO - mozversion platform_changeset: d1d47ba19ce9d46222030d491f9fe28dbf80be12 05:27:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:27:54 INFO - mozversion platform_version: 48.0a1 05:27:54 INFO - using testdate: 1457872074 05:27:54 INFO - actual date: 1457872074 05:27:54 INFO - starting webserver on 'localhost:49271' 05:27:54 INFO - SUITE-START | Running 2 tests 05:27:54 INFO - TEST-START | dromaeo_css 05:27:54 INFO - operating with platform_type : mac_ 05:27:54 INFO - Initialising browser for dromaeo_css test... 05:27:54 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/tmp0x96ur/profile http://localhost:49271/getInfo.html) 05:27:58 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 05:27:58 INFO - PROCESS | 1670 | colorDepth:24 05:27:58 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 05:27:58 INFO - PROCESS | 1670 | __metrics 05:27:58 ERROR - PROCESS | 1670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 05:27:58 INFO - TEST-INFO | 1670: exit 0 05:27:58 INFO - Browser initialized. 05:27:58 INFO - Running cycle 1/1 for dromaeo_css test... 05:27:58 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/tmp0x96ur/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:28:10 INFO - PROCESS | 1676 | RSS: Main: 255754240 05:28:10 INFO - PROCESS | 1676 | 05:29:00 INFO - PROCESS | 1676 | 1457872140483 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:31:11 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 05:31:12 INFO - PROCESS | 1676 | RSS: Main: 272240640 05:31:12 INFO - PROCESS | 1676 | 05:34:14 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 05:34:15 INFO - PROCESS | 1676 | RSS: Main: 283496448 05:34:15 INFO - PROCESS | 1676 | 05:37:17 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 05:37:17 INFO - PROCESS | 1676 | RSS: Main: 285573120 05:37:17 INFO - PROCESS | 1676 | 05:40:19 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 05:40:20 INFO - PROCESS | 1676 | RSS: Main: 288137216 05:40:20 INFO - PROCESS | 1676 | 05:43:22 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 05:43:23 INFO - PROCESS | 1676 | RSS: Main: 289554432 05:43:23 INFO - PROCESS | 1676 | 05:46:25 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 05:46:26 INFO - PROCESS | 1676 | RSS: Main: 291864576 05:46:26 INFO - PROCESS | 1676 | 05:46:26 INFO - PROCESS | 1676 | __start_tp_report 05:46:26 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 05:46:26 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 05:46:26 INFO - PROCESS | 1676 | |i|pagename|runs| 05:46:26 INFO - PROCESS | 1676 | |0;dojo.html;2915.912522624322;3497.772644778089;3525.3301872644197;3525.7884526928387;3544.184837487376;5800.506956908668;5818.185454036433;5836.562257830664;5876.382979787125;5882.44116808903;5654.180143879135;5749.108888122338;5827.766889324422;5896.2606031220785;5991.370906054867;5216.532028953273;5225.790968361271;5268.420473747885;5338.973305133469;5351.304330437038;5325.627206095575;5361.705106219176;5387.488188622095;5403.540699040566;5409.864753381157;4443.200223959686;5066.6200034997155;5286.841394758163;5293.417724050351;5319;5311.990721762852;5312.76092575835;5313.840584782462;5327.094393953037;5343.412224655285;5135.486451354872;5274.235235890813;5300.946990530122;5331.493508116722;5345.5990800689715;5669.149627555858;5700.486956173964;5757.769689212427;5785.826425207209;5796.681182534959;5246.973765131188;5418.674879507243;6264.7807326743805;6264.843378915518;6296.527760417987;6156.3843615638525;6161.599496032743;6239.594426362272;6246.250449946036;6260.248770147611;5957.314908785458;5965.373635768268;5968.31364393096;5976.462118409364;6014.75940962361;6294;6335.841603959938;6336.904946425807;6350.301466838644;6354.205724284465;6071.726772295257;6103.792276408673;6229.813105606839;6248.281447633581;6249.281332646713;6218.751249950042;6236.469900058455;6255.593386429959;6263.96868015657;6270.404311590391;6101.368489499298;6111.713288451782;6265.624062556261;6300.558960872695;6306.211723534559;5368.899375627987;6132.263729246545;6149.2313460817395;6163.3836616338;6165.414285642857;5003.5997120230295;5007.84976450707;5010.073136469765;5017.724025178577;5039.193729003342;4426.3581780641625;4446.644268458515;4447.888802779892;4493.820247190141;4531.980304431542;5128.999845030258;5766;5930.673812940329;6074.210352654215;6091.725872335755;6198.504119670415;6199.256089269226;6271.059341098871;6273.62358258506;6284.780032698925;5955.106733989936;6038.758449661965;6055.333913269536;6067.217597919783;6099.512039036867;5318.095923692981;5409.594280428983;5484.369297530835;5484.396716361197;5535.418781027934;6363.268224154282;6445.581037232565;6448.548601597843;6456.709448074754;6460.676966151674;6181.165542651865;6235.875282494416;6250.937490625036;6261.812145635638;6265;6354.555181137276;6355.3644635536075;6368.235811702625;6395.744170233139;6421.743130274924;6155.507559395148;6210.627362358273;6240.095186198067;6243.001119820807;6261.96869015652;5027;6173.259208894961;6235.688215589294;6243.500519958483;6261.499080073674;5018.698878067182;5458.8908221834545;6084;6131.927227014103;6282.403171698681;5490.91763623538;5994.400559944145;6222.346653601488;6233.376662333731;6270;5965.164876917322;5993.101034844633;6082.574219804571;6089.238845144357;6183.752649894134;4989.201727723546;5704.11586204139;6103.216452666749;6171.814845554641;6185.165002724574;6093.878122437438;6115.082737589397;6125.295591007091;6152.107944347955;6163.506919446523 05:46:26 INFO - PROCESS | 1676 | |1;ext.html;471.19190588141333;512.79231911076;570.287141073658;593.0067137544612;642.299893116503;38666;39097;39100.41349379758;39107;39179.0205244869;40680.38979415304;41003;41052.79473602628;41464;41518;9437.95281023594;9738.269629777795;9746.853797193047;9757.170640495566;9771.804563908718;9621.278404119685;9718.854217186748;9735.756606084833;9757.804843903117;9783.804323913517;9743.220542356594;9763.658271960483;9766.706998790047;9776.560054797515;9825.361351512129;9738.51307434629;9784.95107524465;9788.119069283763;9806.117449429514;9853.90146098537;9549.140577348002;9671.854922176173;9679.274054445945;9698.321117521777;9716.854247186298;38902.02744931371;39171.216575668615;39186;39329.41005884914;39520.40719389183;2632.3682316243962;3143.229908672367;3194.6166460024715;3225.854836532362;3472.791632502058;27037;27425.451490970267;27454.5881811773;27725.58411623827;27755.444891102066;2748.738869807365;2753.6833264174475;2758.4069425073703;2778.2220978126156;2860.3850172213074;427420;430124;430254;431169;432163;67134.66432667903;67487.65024699479;67712;67805;67843;77148;77351;77504.61247693725;78397.82403263956;78542.6072869632;17008.404705835237;17115.572110697332;17130.40043598468;17255.309787608607;17273.481795546155;12357;12395.75208495843;12834.16577922432;12907.741845163231;12922.160059596095;22304.21935232259;22506.66240006401;22743.09027638876;22832.346824508;22832.771672283397;9513.952430237805;9815.116639502336;9822.066903644143;9828.31201815866;9849.21206303494;907.1200935093082;990.8563258327503;1011.701548043329;1115.1636272795404;1180.2564384437921;29944.850275748482;30122.84938575337;30386.240343991576;30804.845975770426;30824.383512330078;1057.8043062033548;1078.9190810689072;1102.9007389334838;1158.976820463586;1176.8881956214318;13870.029097963248;15194.447744643872;15295.311710973034;15546.455874044354;15566.910316277977;527636;994366;1018174;1020484;1022501;64870;64978.02532962009;65431.67284163549;65612;65774;1221.1390969366576;1423.7721964485634;1436.4756863744658;1444.4872070414851;1453.229788212228;31103.84448077745;31447;31678.683213167573;32050;32265.838670806497;54013.91972160614;54102.91794164173;54225;54858.72570637121;54999.52502137333;495742;496804;498422;501497;502115;34290;34804.477932831534;45301;46223.76888115538;47375.81560461016;44150.55849441593;44498;44500.66498005065;44509;44668.43660471868;36845.81577092098;36856;36911.44632830563;37141.257174856895;37430;37646.43530346992;37858;37905.05237369088;38630;39201.019974500865;32684.50973235451;37846.59380655754;37964.2407151861;38427.615723842406;40055.59944400635;31918.52122218122;32297.192570185933;32701.672983270815;32850;33289.500657489676;23432.414189645395;23456;24383.51232975366;24481.38796530101;24764.628530571696 05:46:26 INFO - PROCESS | 1676 | |2;jquery.html;353.14186526740014;359.9478075679026;365.2639930539962;368.5927050609077;369.63775500010007;18245.270189192415;18865.811341886576;19050.237990480382;19349.419517414466;20707.792922070774;11945.64163075107;20082.29711960082;20173.29393471229;20734.792652073476;20755.68866467004;5193.948060519394;5366.248725178459;5382.461753824626;5385.246065550826;5406.756695948672;3603.4955106285142;5346.4118946915805;5770.624909380897;6039.456448919596;6059.272887253535;6030.457258846703;6032.095185722133;6042.637441753487;6049.909251361233;6054.6367217966845;5880.411958804107;6445.452136568398;6515.185601799752;6537.901931471032;6552.180977377828;4818.542238487373;4886.047220791947;5700.9429905701245;5715.542756579505;5737.340205876336;12499.937500312531;13218.405171767294;13238.86761132386;13243.73512529744;13279.336033198302;2108.8945552722457;2221.688963545105;2458.2870967419426;2493.4265119022543;2512.736162702908;9459.90540094597;9994.950025249827;10101.848472272923;12242.387880606024;14611.342489587994;1708.3679038755615;1746.8777185597014;1777.3956854669345;1816.0919540229886;1859.8233167849169;98815.50592247065;99768.50115749375;102486;106157.99999999923;106269;11330.433478326051;11498.367589782474;11507.539698411969;11598.76802463946;11603.76792464146;13607.115537490032;13690.93154534221;13765.518206862913;13794.379252933642;13842.169469831842;6919.273476285019;8336.083030866599;8507.191816777397;8540.188682075193;8555.27280181179;7588.127365352944;8527.360447966428;8540.615672294762;8552.315814734806;8672.26285765717;3580.4092324766643;4479.372887795711;4521.977390113028;4565.771711414416;4596.7931443085145;1810;1852.2405813616353;1893.337331933812;1932.2271091563487;1944.9124789384512;817.8999246014101;861.9827603447895;903.8373092843351;1016.9440680762481;1040.1990467340106;18788.71816922747;19778.10998505071;20086;20288.087036083412;20403.59192816165;800.9038915330198;915.3043686798081;930.0838673906197;986.2800155886243;1017.7150397888603;10432.321899076536;10733.570657173626;10755.677329680122;10838.496653373082;10885.346879187275;621948.5610287769;633811;640743;661308;664309.3569064247;85354;107348.46325768321;111132;112064.43967780271;114729.4263528677;915.922146617545;1032.7314898126692;1034.446571084466;1109.0905457524752;1111.793703831352;17668.82331176723;17689.734653980457;17881.642367152843;18196.72704909401;18311.725324120416;47267.345642902335;49625.00749985052;49810;51286.48713512817;51438;68819;68978.96531551931;69619.60760784858;71077.28922710707;71268.64365678138;7726.536407815549;7784.455088143775;7834.608269586612;7921.801954950942;8124.471909325875;7682.347000505019;10853;11547.769044618892;11981.700457488632;12274.263544187377;10268.383896966207;10379.532921018723;10540.894591053991;10657.520411581343;10690.62582809598;8223.424360294961;10356.067953883885;10357.223208259562;10692.19808514349;10799.40603266828;10737.14102871784;10883.292585982203;10982.560697572007;11163.162762792661;11175.329480231212;7547.886781698169;7658.885116723142;7703.614819258903;7749;7874.291313781787;10555.680539932508;10815.134789217002;10914.290571112851;11010.724731881766;11016.944915275693 05:46:26 INFO - PROCESS | 1676 | |3;mootools.html;1584.706829236591;1595.6330044089855;1885.632301701168;1975.74315339006;1993.4717299915517;8018.358531317495;8604.741857744262;8797.032326444094;8995.640174393024;9000.324975626829;8785;8828.690995815148;8831.470111793296;8892.822143557125;8905.821883562325;2477.1949116537107;2504.0734928076636;2509.711383190929;2512.9748702512925;2514.1326242446326;2446.0582675669907;2472.1223965492263;2497.5379554782335;2505.2734706934966;2530.00064974335;2482.2925466242123;2503;2508.272600945733;2520.269121954631;2520.281719709883;2480.6279058141245;2496.251124662603;2510.7614776596192;2521.4578865543904;2533.4933013397394;2472.554940110779;2508.5610018246916;2515.0065724039086;2521.596544552881;2535.632333311678;8902.42134261271;8938.955305223431;9000.819983600357;9011.909880901172;9012.504312262823;5375.784968601251;5509.283793106871;5553.194786755938;5570.6657600544095;5592.440755924375;3596.8021758803256;3686.4101743720876;3720.7023438125157;3726.795026273554;3740.738148329618;1055.4669891704716;1072.3297938788257;1073.2862646340175;1083.5774048121239;1085.5169449594855;10124.493775311204;11979.820302695467;12060.819087713691;12065.034797216202;12065.215760975596;4933.45731969483;4962.5533701967;4999.75001249936;5000.024995125916;5036.697798132123;10289.639862604923;10307.742306442398;10310.793784124275;10313.329633573794;10325.48372581368;5448;5451.836444906659;5528.143137813645;5545.584081193927;5613.859653508695;4457.7548234846745;4791.401074865642;4853.708777473363;4942;4953.108440480676;3508.7894726316504;3530.6936433519763;4009.4787677602308;4028.5568587455355;4038.959610403917;1167.3054532553117;1337.2645045225281;1337.7190789934027;1347.299404309773;1361.6051345109806;1331.380907877822;1334.6996925691642;1348.966275843092;1371.2869307959804;1385.9307034648227;8176.713815016446;8365.372597055246;8366.498010119412;8404.033536143299;8422.747317580483;519.929809475716;524.9868753281198;528.7092099345344;530.1888111189886;531.8909623527168;5099.97450012755;6292.678537507083;6329.461995730322;6329.493640508748;6381.521385896076;10459.058684718411;10715.571377144826;10807.621733239455;10833.404162771123;10862.728431789268;10671.146308295318;10687.419454739907;10699.946500267604;10744.086752625957;10800;8486.40595158333;8491;8492.575371231414;8512.446690965067;8531.146885311544;7912.0901096374655;7916.525008499278;7955.721549745963;7975.2423519765525;8030.558319292495;9371.156595906401;9508.714738557577;9540.761480963032;9610.231181505602;9712;9867.259955503223;10075.395476271447;10108.797824043331;10118.443485608363;10155.238357123097;6285.371462853678;6821.113255276782;7339.559626422431;7583.9620801895635;7639.809004774703;7051.858962820817;8417.326613870999;8462.619182136696;8481.787955301166;8491.19333663301;7447;7591.316781489471;7638.847223055396;7647.502912310682;7697.999260096151;7391.002214701161;7403.296686814744;7429.7399591014055;7536.886946695914;7550.66022028999;7791.4935529190425;7862.685492580462;7875.133735288999;7879.290863822283;7894.210578942289;7061.152661680631;7093.893591596234;7140.321669441395;7140.928590714234;7154.141503019463;7178.389836863925;7217.783466496014;7230.6384680766805;7267.491275610657;7276.8908466374105 05:46:26 INFO - PROCESS | 1676 | |4;prototype.html;327.8426355349432;328.7632904308898;332.72051476759515;336.75080440474056;338.77870277649083;5400.8919821603595;6738.730450781969;6741.865162696743;6742.494312926526;6767.458603311736;6709.429698475623;6717.832054198648;6746.561473504219;6752.257251702309;6774.661266936646;4644;4791.3531673224015;4943.357363542752;4973.676711013773;4973.93581663611;4263.658907287425;4948.2824990376375;4999.175136102539;5010.123228435027;5029.371328583927;4162;4786.545278198583;4914.557689807916;4921.040397122562;4926.778294976717;4241.384999175133;4359.8446411700925;4943.209086546153;4950.257461380804;4967.230079337691;3762.3792074307707;4241.151769646083;4242.893927651802;4255.191513612434;4261.296886013804;5159.458256883011;6089.482393996515;6484.059811327331;6495.914440640658;6541.9345806541805;5690.772369105272;5692.203091567142;5731.168980497804;5740.655560666373;5753.510951569122;7197.992281080653;7212.819679508002;7217.8917316240295;7220.5667659940045;7234.927650723478;4581.671315318554;4593.127305811885;4595.310703394484;4599.632029437637;4616.838410655644;7614.505057171266;7651.387888968925;7662.1954694756805;7665.731699390551;7693.153753087156;4392.3411488277015;4508.909821803545;4548.636109111263;4630.560096790799;4675.7895894684825;4752.239641657387;4767.713937163781;4768.76156192196;4771.570558649738;4786.234202527648;5648.802291919763;5655.575831812631;5701.230333904953;5704.429557044263;5707.486326230659;5785.247917770663;7263.201047884729;7270.9636451817405;7282.4902256841515;7292.708291668274;1636.2882146266413;1651.4467653336267;1651.9587010324838;1653.4047742812577;1664.950051498457;1026.7843752811843;1060.2578195263347;1065.5577935156978;1070.1224995503612;1083.4095417997053;6839.213490448563;6903.585784852925;6936.583804971718;6948.270431604608;6957.582545047313;7538.623068846646;7547.16981132075;7556.886646700304;7558.58427786466;7566.167721550625;6897.206821215524;6911.3779759821855;6914.4468442525485;6922.06552115468;6941.375276225164;3855.132595166121;3907.4529565860803;3964.7621142731527;4017.055991841915;4020.4773379461067;7763.650635721406;7973.322267607318;8028.036635603765;8034.638441270157;8074.515529068275;7429.21993190718;7601.745711957576;7873;7882.330001949784;7902.328302094386;7992.68029278834;7995;8005.199480052064;8007.279344858991;8010.919890801018;5709.858028394421;6152.938470615237;7418.548845953951;7485.214052524407;7598.20218877032;6264.874702505833;7437.628118593941;7456.6271686414375;7496.437767167593;7530.359919406912;7115.897035959228;7254.202037775735;7989.161138080418;7995.560244186626;8003.439759216799;4584.862454126382;4686.562987246544;4689.531046895283;4701.224297990793;4718.929216061831;6005.87988240224;6779.457643388616;7296.598687072262;7509.699612015458;7564.281393267631;6196.504279657706;6984.720611175496;7290.927090729237;7327.963360183165;7405.333519983227;5289.497497737709;7041.471889608402;7195.8920616191845;7345.3021962913435;7346.081739782528;7147.8570428592175;7160.355567998905;7204.855902882018;7282.2353652867805;7314.854612516456;7128.28717128283;7325.011123498472;7357.969884216107;7361.705531778883;7382.483226174117;7097.148342198969;7121;7172.892406614009;7187.676554554953;7223.952526883678 05:46:26 INFO - PROCESS | 1676 | |5;yui.html;653.4674240494;695.1033167214297;697.139033293882;731.3381389842191;755.8677231484493;14625.488107916211;14723.190224537646;14866;14889.404423823034;14922.477713280037;13848.584542463743;13928.860711392883;15463.922680386611;15879.444219452322;15905.44330948417;931.5435436636034;950.4867371619317;951.1772316945827;952.5665822050985;953.3850666320219;750.0549307872093;930.4463844012802;936.6440752514069;942.3686130292687;954.3891909178096;988.5106872098321;992.503748125937;993.0913214408844;993.8757655293089;995.1392045880298;974.0600320690532;982.0964712464514;982.2093214961952;984.5717113055844;986.4673076538661;738.9741359052462;740.4557650127152;744.3301029073823;745.1691364129011;745.5303159009843;15147.772783408258;15317.6170595736;15372.538823835303;15591.454299099478;15611.219439028117;12395.442205100791;12510.31193284369;12586.056045796602;12616;12734.936325318315;9944.602215911355;9978.151857092156;10145.543450544743;10159;10378.221633377527;3419.777714448553;3439.5356626855305;3443.2080621456953;3445.3626079175183;3452.6202117767025;55299.61750956258;78375.6081219596;82394.17605823986;83794.32411351739;85284.72072918911;9212.585433655502;9228.630854765868;9230.815383692288;9292.39599426035;9435;21451.356459306247;21502.354929352143;21838.126474940826;21845.67231491529;21918.123275068818;7464.365528930101;7539.208383119803;7570.735024274124;7702.152763196044;7742.380609551223;4039.3537034074993;4102.2410853992105;4102.2821006323775;4106.527749308868;4113.4858142732155;3602;3636.581793093828;3645.2709458108484;3653.9817300913323;3661.2677464507206;541.5802752866481;655.4232275597539;657.2408867757747;663.3963093584815;663.548786824954;523.5942144837782;575.3527281807966;580.3963877567282;599.4694695194784;610.4688920638984;6696.59820410777;7741.4968027079185;7978.6409611567615;8064.354851611857;8125.593720313961;560.3136158206165;600.5015836855487;609.2232403685337;614.1463365921372;625.1591609285504;2802.341449759346;3576.7138628909624;3726.627337266306;3727.3290807654885;3960.980195099006;88032;89351.55324223338;91308.54345728229;91431.54284228536;92959;79175.20824791794;79501;80470.59764701256;80808;81971.5901420501;70670;71286.99999999897;71468.28531714616;71711.64144179245;72809;6312.84217894538;7462.141853686679;7507.174210836913;7541.5475071495885;7597.430192735456;39722.808315750575;51538.96922061613;51977.7401112992;52350.21474677959;52359.73820130875;65068.34931650812;66516.6674166626;68573.65713171402;72748;73559.26440735524;9845.704628861145;9847.950760246153;9893.258005649748;9985.101340879355;10037.197024237897;8670.263027642468;8714.91285087141;10636.574537018432;11037.227394082338;11118.332900026024;8227.79430514218;8556.914430855611;10054.8491772622;10337.844932326172;10395.740106497096;8061.516309021477;9724.562394692115;10027.649032284127;10060.748481287734;10334.224933130195;9719.27105467107;9768.267379946674;9941.403515789076;10046.296759226783;10164.949175254076;8570.78573035679;8832.558372081241;8879.689210877588;8897.955510222408;8976.102389760972;7944.563049032358;8565.657373704982;9317.928438229419;9648.75878103053;9655.855162172713 05:46:26 INFO - PROCESS | 1676 | __end_tp_report 05:46:26 INFO - PROCESS | 1676 | __start_cc_report 05:46:26 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,361 05:46:26 INFO - PROCESS | 1676 | __end_cc_report 05:46:26 INFO - PROCESS | 1676 | __startTimestamp1457873186082__endTimestamp 05:46:26 INFO - PROCESS | 1676 | 05:46:26 INFO - PROCESS | 1676 | ------- Summary: start ------- 05:46:26 INFO - PROCESS | 1676 | Number of tests: 6 05:46:26 INFO - PROCESS | 1676 | 05:46:26 INFO - PROCESS | 1676 | [#0] dojo.html Cycles:165 Average:5768.38 Median:6055.33 stddev:649.30 (10.7%) stddev-sans-first:611.52 05:46:26 INFO - PROCESS | 1676 | Values: 2915.9 3497.8 3525.3 3525.8 3544.2 5800.5 5818.2 5836.6 5876.4 5882.4 5654.2 5749.1 5827.8 5896.3 5991.4 5216.5 5225.8 5268.4 5339.0 5351.3 5325.6 5361.7 5387.5 5403.5 5409.9 4443.2 5066.6 5286.8 5293.4 5319.0 5312.0 5312.8 5313.8 5327.1 5343.4 5135.5 5274.2 5300.9 5331.5 5345.6 5669.1 5700.5 5757.8 5785.8 5796.7 5247.0 5418.7 6264.8 6264.8 6296.5 6156.4 6161.6 6239.6 6246.3 6260.2 5957.3 5965.4 5968.3 5976.5 6014.8 6294.0 6335.8 6336.9 6350.3 6354.2 6071.7 6103.8 6229.8 6248.3 6249.3 6218.8 6236.5 6255.6 6264.0 6270.4 6101.4 6111.7 6265.6 6300.6 6306.2 5368.9 6132.3 6149.2 6163.4 6165.4 5003.6 5007.8 5010.1 5017.7 5039.2 4426.4 4446.6 4447.9 4493.8 4532.0 5129.0 5766.0 5930.7 6074.2 6091.7 6198.5 6199.3 6271.1 6273.6 6284.8 5955.1 6038.8 6055.3 6067.2 6099.5 5318.1 5409.6 5484.4 5484.4 5535.4 6363.3 6445.6 6448.5 6456.7 6460.7 6181.2 6235.9 6250.9 6261.8 6265.0 6354.6 6355.4 6368.2 6395.7 6421.7 6155.5 6210.6 6240.1 6243.0 6262.0 5027.0 6173.3 6235.7 6243.5 6261.5 5018.7 5458.9 6084.0 6131.9 6282.4 5490.9 5994.4 6222.3 6233.4 6270.0 5965.2 5993.1 6082.6 6089.2 6183.8 4989.2 5704.1 6103.2 6171.8 6185.2 6093.9 6115.1 6125.3 6152.1 6163.5 05:46:26 INFO - PROCESS | 1676 | 05:46:26 INFO - PROCESS | 1676 | [#1] ext.html Cycles:180 Average:75316.87 Median:39139.11 stddev:178812.07 (456.9%) stddev-sans-first:179225.38 05:46:26 INFO - PROCESS | 1676 | Values: 471.2 512.8 570.3 593.0 642.3 38666.0 39097.0 39100.4 39107.0 39179.0 40680.4 41003.0 41052.8 41464.0 41518.0 9438.0 9738.3 9746.9 9757.2 9771.8 9621.3 9718.9 9735.8 9757.8 9783.8 9743.2 9763.7 9766.7 9776.6 9825.4 9738.5 9785.0 9788.1 9806.1 9853.9 9549.1 9671.9 9679.3 9698.3 9716.9 38902.0 39171.2 39186.0 39329.4 39520.4 2632.4 3143.2 3194.6 3225.9 3472.8 27037.0 27425.5 27454.6 27725.6 27755.4 2748.7 2753.7 2758.4 2778.2 2860.4 427420.0 430124.0 430254.0 431169.0 432163.0 67134.7 67487.7 67712.0 67805.0 67843.0 77148.0 77351.0 77504.6 78397.8 78542.6 17008.4 17115.6 17130.4 17255.3 17273.5 12357.0 12395.8 12834.2 12907.7 12922.2 22304.2 22506.7 22743.1 22832.3 22832.8 9514.0 9815.1 9822.1 9828.3 9849.2 907.1 990.9 1011.7 1115.2 1180.3 29944.9 30122.8 30386.2 30804.8 30824.4 1057.8 1078.9 1102.9 1159.0 1176.9 13870.0 15194.4 15295.3 15546.5 15566.9 527636.0 994366.0 1018174.0 1020484.0 1022501.0 64870.0 64978.0 65431.7 65612.0 65774.0 1221.1 1423.8 1436.5 1444.5 1453.2 31103.8 31447.0 31678.7 32050.0 32265.8 54013.9 54102.9 54225.0 54858.7 54999.5 495742.0 496804.0 498422.0 501497.0 502115.0 34290.0 34804.5 45301.0 46223.8 47375.8 44150.6 44498.0 44500.7 44509.0 44668.4 36845.8 36856.0 36911.4 37141.3 37430.0 37646.4 37858.0 37905.1 38630.0 39201.0 32684.5 37846.6 37964.2 38427.6 40055.6 31918.5 32297.2 32701.7 32850.0 33289.5 23432.4 23456.0 24383.5 24481.4 24764.6 05:46:26 INFO - PROCESS | 1676 | 05:46:26 INFO - PROCESS | 1676 | [#2] jquery.html Cycles:180 Average:34356.57 Median:2165.29 stddev:106439.33 (4915.7%) stddev-sans-first:106707.30 05:46:26 INFO - PROCESS | 1676 | Values: 353.1 359.9 365.3 368.6 369.6 18245.3 18865.8 19050.2 19349.4 20707.8 11945.6 20082.3 20173.3 20734.8 20755.7 5193.9 5366.2 5382.5 5385.2 5406.8 3603.5 5346.4 5770.6 6039.5 6059.3 6030.5 6032.1 6042.6 6049.9 6054.6 5880.4 6445.5 6515.2 6537.9 6552.2 4818.5 4886.0 5700.9 5715.5 5737.3 12499.9 13218.4 13238.9 13243.7 13279.3 2108.9 2221.7 2458.3 2493.4 2512.7 9459.9 9995.0 10101.8 12242.4 14611.3 1708.4 1746.9 1777.4 1816.1 1859.8 98815.5 99768.5 102486.0 106158.0 106269.0 11330.4 11498.4 11507.5 11598.8 11603.8 13607.1 13690.9 13765.5 13794.4 13842.2 6919.3 8336.1 8507.2 8540.2 8555.3 7588.1 8527.4 8540.6 8552.3 8672.3 3580.4 4479.4 4522.0 4565.8 4596.8 1810.0 1852.2 1893.3 1932.2 1944.9 817.9 862.0 903.8 1016.9 1040.2 18788.7 19778.1 20086.0 20288.1 20403.6 800.9 915.3 930.1 986.3 1017.7 10432.3 10733.6 10755.7 10838.5 10885.3 621948.6 633811.0 640743.0 661308.0 664309.4 85354.0 107348.5 111132.0 112064.4 114729.4 915.9 1032.7 1034.4 1109.1 1111.8 17668.8 17689.7 17881.6 18196.7 18311.7 47267.3 49625.0 49810.0 51286.5 51438.0 68819.0 68979.0 69619.6 71077.3 71268.6 7726.5 7784.5 7834.6 7921.8 8124.5 7682.3 10853.0 11547.8 11981.7 12274.3 10268.4 10379.5 10540.9 10657.5 10690.6 8223.4 10356.1 10357.2 10692.2 10799.4 10737.1 10883.3 10982.6 11163.2 11175.3 7547.9 7658.9 7703.6 7749.0 7874.3 10555.7 10815.1 10914.3 11010.7 11016.9 05:46:26 INFO - PROCESS | 1676 | 05:46:26 INFO - PROCESS | 1676 | [#3] mootools.html Cycles:180 Average:6110.19 Median:522.46 stddev:3223.47 (617.0%) stddev-sans-first:3214.57 05:46:26 INFO - PROCESS | 1676 | Values: 1584.7 1595.6 1885.6 1975.7 1993.5 8018.4 8604.7 8797.0 8995.6 9000.3 8785.0 8828.7 8831.5 8892.8 8905.8 2477.2 2504.1 2509.7 2513.0 2514.1 2446.1 2472.1 2497.5 2505.3 2530.0 2482.3 2503.0 2508.3 2520.3 2520.3 2480.6 2496.3 2510.8 2521.5 2533.5 2472.6 2508.6 2515.0 2521.6 2535.6 8902.4 8939.0 9000.8 9011.9 9012.5 5375.8 5509.3 5553.2 5570.7 5592.4 3596.8 3686.4 3720.7 3726.8 3740.7 1055.5 1072.3 1073.3 1083.6 1085.5 10124.5 11979.8 12060.8 12065.0 12065.2 4933.5 4962.6 4999.8 5000.0 5036.7 10289.6 10307.7 10310.8 10313.3 10325.5 5448.0 5451.8 5528.1 5545.6 5613.9 4457.8 4791.4 4853.7 4942.0 4953.1 3508.8 3530.7 4009.5 4028.6 4039.0 1167.3 1337.3 1337.7 1347.3 1361.6 1331.4 1334.7 1349.0 1371.3 1385.9 8176.7 8365.4 8366.5 8404.0 8422.7 519.9 525.0 528.7 530.2 531.9 5100.0 6292.7 6329.5 6329.5 6381.5 10459.1 10715.6 10807.6 10833.4 10862.7 10671.1 10687.4 10699.9 10744.1 10800.0 8486.4 8491.0 8492.6 8512.4 8531.1 7912.1 7916.5 7955.7 7975.2 8030.6 9371.2 9508.7 9540.8 9610.2 9712.0 9867.3 10075.4 10108.8 10118.4 10155.2 6285.4 6821.1 7339.6 7584.0 7639.8 7051.9 8417.3 8462.6 8481.8 8491.2 7447.0 7591.3 7638.8 7647.5 7698.0 7391.0 7403.3 7429.7 7536.9 7550.7 7791.5 7862.7 7875.1 7879.3 7894.2 7061.2 7093.9 7140.3 7140.9 7154.1 7178.4 7217.8 7230.6 7267.5 7276.9 05:46:26 INFO - PROCESS | 1676 | 05:46:26 INFO - PROCESS | 1676 | [#4] prototype.html Cycles:180 Average:5861.68 Median:6740.30 stddev:1925.73 (28.6%) stddev-sans-first:1885.81 05:46:26 INFO - PROCESS | 1676 | Values: 327.8 328.8 332.7 336.8 338.8 5400.9 6738.7 6741.9 6742.5 6767.5 6709.4 6717.8 6746.6 6752.3 6774.7 4644.0 4791.4 4943.4 4973.7 4973.9 4263.7 4948.3 4999.2 5010.1 5029.4 4162.0 4786.5 4914.6 4921.0 4926.8 4241.4 4359.8 4943.2 4950.3 4967.2 3762.4 4241.2 4242.9 4255.2 4261.3 5159.5 6089.5 6484.1 6495.9 6541.9 5690.8 5692.2 5731.2 5740.7 5753.5 7198.0 7212.8 7217.9 7220.6 7234.9 4581.7 4593.1 4595.3 4599.6 4616.8 7614.5 7651.4 7662.2 7665.7 7693.2 4392.3 4508.9 4548.6 4630.6 4675.8 4752.2 4767.7 4768.8 4771.6 4786.2 5648.8 5655.6 5701.2 5704.4 5707.5 5785.2 7263.2 7271.0 7282.5 7292.7 1636.3 1651.4 1652.0 1653.4 1665.0 1026.8 1060.3 1065.6 1070.1 1083.4 6839.2 6903.6 6936.6 6948.3 6957.6 7538.6 7547.2 7556.9 7558.6 7566.2 6897.2 6911.4 6914.4 6922.1 6941.4 3855.1 3907.5 3964.8 4017.1 4020.5 7763.7 7973.3 8028.0 8034.6 8074.5 7429.2 7601.7 7873.0 7882.3 7902.3 7992.7 7995.0 8005.2 8007.3 8010.9 5709.9 6152.9 7418.5 7485.2 7598.2 6264.9 7437.6 7456.6 7496.4 7530.4 7115.9 7254.2 7989.2 7995.6 8003.4 4584.9 4686.6 4689.5 4701.2 4718.9 6005.9 6779.5 7296.6 7509.7 7564.3 6196.5 6984.7 7290.9 7328.0 7405.3 5289.5 7041.5 7195.9 7345.3 7346.1 7147.9 7160.4 7204.9 7282.2 7314.9 7128.3 7325.0 7358.0 7361.7 7382.5 7097.1 7121.0 7172.9 7187.7 7224.0 05:46:26 INFO - PROCESS | 1676 | 05:46:26 INFO - PROCESS | 1676 | [#5] yui.html Cycles:180 Average:18020.39 Median:71377.64 stddev:25806.30 (36.2%) stddev-sans-first:25845.75 05:46:26 INFO - PROCESS | 1676 | Values: 653.5 695.1 697.1 731.3 755.9 14625.5 14723.2 14866.0 14889.4 14922.5 13848.6 13928.9 15463.9 15879.4 15905.4 931.5 950.5 951.2 952.6 953.4 750.1 930.4 936.6 942.4 954.4 988.5 992.5 993.1 993.9 995.1 974.1 982.1 982.2 984.6 986.5 739.0 740.5 744.3 745.2 745.5 15147.8 15317.6 15372.5 15591.5 15611.2 12395.4 12510.3 12586.1 12616.0 12734.9 9944.6 9978.2 10145.5 10159.0 10378.2 3419.8 3439.5 3443.2 3445.4 3452.6 55299.6 78375.6 82394.2 83794.3 85284.7 9212.6 9228.6 9230.8 9292.4 9435.0 21451.4 21502.4 21838.1 21845.7 21918.1 7464.4 7539.2 7570.7 7702.2 7742.4 4039.4 4102.2 4102.3 4106.5 4113.5 3602.0 3636.6 3645.3 3654.0 3661.3 541.6 655.4 657.2 663.4 663.5 523.6 575.4 580.4 599.5 610.5 6696.6 7741.5 7978.6 8064.4 8125.6 560.3 600.5 609.2 614.1 625.2 2802.3 3576.7 3726.6 3727.3 3961.0 88032.0 89351.6 91308.5 91431.5 92959.0 79175.2 79501.0 80470.6 80808.0 81971.6 70670.0 71287.0 71468.3 71711.6 72809.0 6312.8 7462.1 7507.2 7541.5 7597.4 39722.8 51539.0 51977.7 52350.2 52359.7 65068.3 66516.7 68573.7 72748.0 73559.3 9845.7 9848.0 9893.3 9985.1 10037.2 8670.3 8714.9 10636.6 11037.2 11118.3 8227.8 8556.9 10054.8 10337.8 10395.7 8061.5 9724.6 10027.6 10060.7 10334.2 9719.3 9768.3 9941.4 10046.3 10164.9 8570.8 8832.6 8879.7 8898.0 8976.1 7944.6 8565.7 9317.9 9648.8 9655.9 05:46:26 INFO - PROCESS | 1676 | -------- Summary: end -------- 05:46:26 INFO - PROCESS | 1676 | 05:46:26 INFO - TEST-INFO | 1676: exit 0 05:46:26 INFO - TEST-OK | dromaeo_css | took 1111753ms 05:46:26 INFO - TEST-START | kraken 05:46:26 INFO - operating with platform_type : mac_ 05:46:26 INFO - Initialising browser for kraken test... 05:46:26 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/tmpC0s65d/profile http://localhost:49271/getInfo.html) 05:46:29 INFO - PROCESS | 1685 | __metrics Screen width/height:1600/1200 05:46:29 INFO - PROCESS | 1685 | colorDepth:24 05:46:29 INFO - PROCESS | 1685 | Browser inner width/height: 1024/689 05:46:29 INFO - PROCESS | 1685 | __metrics 05:46:29 ERROR - PROCESS | 1685 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 05:46:30 INFO - TEST-INFO | 1685: exit 0 05:46:30 INFO - Browser initialized. 05:46:30 INFO - Running cycle 1/1 for kraken test... 05:46:30 INFO - TEST-INFO | started process 1689 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/tmpC0s65d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:46:42 INFO - PROCESS | 1689 | RSS: Main: 256655360 05:46:42 INFO - PROCESS | 1689 | 05:46:45 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 05:46:45 INFO - PROCESS | 1689 | RSS: Main: 269406208 05:46:45 INFO - PROCESS | 1689 | 05:46:48 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 05:46:49 INFO - PROCESS | 1689 | RSS: Main: 277045248 05:46:49 INFO - PROCESS | 1689 | 05:46:52 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 05:46:52 INFO - PROCESS | 1689 | RSS: Main: 281399296 05:46:52 INFO - PROCESS | 1689 | 05:46:54 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 05:46:55 INFO - PROCESS | 1689 | RSS: Main: 281354240 05:46:55 INFO - PROCESS | 1689 | 05:46:57 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:46:58 INFO - PROCESS | 1689 | RSS: Main: 281931776 05:46:58 INFO - PROCESS | 1689 | 05:47:00 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 05:47:01 INFO - PROCESS | 1689 | RSS: Main: 282775552 05:47:01 INFO - PROCESS | 1689 | 05:47:04 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 05:47:05 INFO - PROCESS | 1689 | RSS: Main: 284975104 05:47:05 INFO - PROCESS | 1689 | 05:47:08 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 05:47:08 INFO - PROCESS | 1689 | RSS: Main: 284209152 05:47:08 INFO - PROCESS | 1689 | 05:47:10 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:47:10 INFO - PROCESS | 1689 | RSS: Main: 282451968 05:47:10 INFO - PROCESS | 1689 | 05:47:12 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:47:13 INFO - PROCESS | 1689 | RSS: Main: 282374144 05:47:13 INFO - PROCESS | 1689 | 05:47:15 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:47:15 INFO - PROCESS | 1689 | RSS: Main: 283095040 05:47:15 INFO - PROCESS | 1689 | 05:47:18 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:47:19 INFO - PROCESS | 1689 | RSS: Main: 282292224 05:47:19 INFO - PROCESS | 1689 | 05:47:21 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:47:22 INFO - PROCESS | 1689 | RSS: Main: 283066368 05:47:22 INFO - PROCESS | 1689 | 05:47:24 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 05:47:24 INFO - PROCESS | 1689 | RSS: Main: 283918336 05:47:24 INFO - PROCESS | 1689 | 05:47:24 INFO - PROCESS | 1689 | __start_tp_report 05:47:24 INFO - PROCESS | 1689 | _x_x_mozilla_page_load 05:47:24 INFO - PROCESS | 1689 | _x_x_mozilla_page_load_details 05:47:24 INFO - PROCESS | 1689 | |i|pagename|runs| 05:47:24 INFO - PROCESS | 1689 | |0;ai-astar;115;111;115;114;115;127;115;114;115;118 05:47:24 INFO - PROCESS | 1689 | |1;audio-beat-detection;151;119;143;149;118;138;139;120;161;118 05:47:24 INFO - PROCESS | 1689 | |2;audio-dft;191;192;198;194;205;220;211;201;199;196 05:47:24 INFO - PROCESS | 1689 | |3;audio-fft;64;79;59;76;85;84;90;125;56;55 05:47:24 INFO - PROCESS | 1689 | |4;audio-oscillator;79;89;120;79;79;80;119;81;79;116 05:47:24 INFO - PROCESS | 1689 | |5;imaging-gaussian-blur;105;132;88;86;89;88;90;86;89;116 05:47:24 INFO - PROCESS | 1689 | |6;imaging-darkroom;134;123;120;109;112;98;154;154;96;107 05:47:24 INFO - PROCESS | 1689 | |7;imaging-desaturate;94;94;100;134;95;91;94;92;90;93 05:47:24 INFO - PROCESS | 1689 | |8;json-parse-financial;55;59;57;56;58;62;58;66;97;56 05:47:24 INFO - PROCESS | 1689 | |9;json-stringify-tinderbox;67;69;65;69;76;70;65;64;72;96 05:47:24 INFO - PROCESS | 1689 | |10;stanford-crypto-aes;82;86;84;85;83;87;84;85;88;84 05:47:24 INFO - PROCESS | 1689 | |11;stanford-crypto-ccm;143;121;140;133;137;127;127;136;146;137 05:47:24 INFO - PROCESS | 1689 | |12;stanford-crypto-pbkdf2;128;142;143;138;138;129;139;143;146;171 05:47:24 INFO - PROCESS | 1689 | |13;stanford-crypto-sha256-iterative;68;68;68;66;69;95;68;65;69;66 05:47:24 INFO - PROCESS | 1689 | __end_tp_report 05:47:24 INFO - PROCESS | 1689 | __start_cc_report 05:47:24 INFO - PROCESS | 1689 | _x_x_mozilla_cycle_collect,947 05:47:24 INFO - PROCESS | 1689 | __end_cc_report 05:47:24 INFO - PROCESS | 1689 | __startTimestamp1457873244306__endTimestamp 05:47:24 INFO - PROCESS | 1689 | 05:47:24 INFO - PROCESS | 1689 | ------- Summary: start ------- 05:47:24 INFO - PROCESS | 1689 | Number of tests: 14 05:47:24 INFO - PROCESS | 1689 | 05:47:24 INFO - PROCESS | 1689 | [#0] ai-astar Cycles:10 Average:115.90 Median:115.00 stddev:4.25 (3.7%) stddev-sans-first:4.50 05:47:24 INFO - PROCESS | 1689 | Values: 115.0 111.0 115.0 114.0 115.0 127.0 115.0 114.0 115.0 118.0 05:47:24 INFO - PROCESS | 1689 | 05:47:24 INFO - PROCESS | 1689 | [#1] audio-beat-detection Cycles:10 Average:135.60 Median:141.00 stddev:15.89 (11.3%) stddev-sans-first:15.85 05:47:24 INFO - PROCESS | 1689 | Values: 151.0 119.0 143.0 149.0 118.0 138.0 139.0 120.0 161.0 118.0 05:47:24 INFO - PROCESS | 1689 | 05:47:24 INFO - PROCESS | 1689 | [#2] audio-dft Cycles:10 Average:200.70 Median:200.00 stddev:9.09 (4.5%) stddev-sans-first:8.94 05:47:24 INFO - PROCESS | 1689 | Values: 191.0 192.0 198.0 194.0 205.0 220.0 211.0 201.0 199.0 196.0 05:47:24 INFO - PROCESS | 1689 | 05:47:24 INFO - PROCESS | 1689 | [#3] audio-fft Cycles:10 Average:77.30 Median:77.50 stddev:21.10 (27.2%) stddev-sans-first:21.83 05:47:24 INFO - PROCESS | 1689 | Values: 64.0 79.0 59.0 76.0 85.0 84.0 90.0 125.0 56.0 55.0 05:47:24 INFO - PROCESS | 1689 | 05:47:24 INFO - PROCESS | 1689 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:79.00 stddev:18.38 (23.3%) stddev-sans-first:18.87 05:47:24 INFO - PROCESS | 1689 | Values: 79.0 89.0 120.0 79.0 79.0 80.0 119.0 81.0 79.0 116.0 05:47:24 INFO - PROCESS | 1689 | 05:47:24 INFO - PROCESS | 1689 | [#5] imaging-gaussian-blur Cycles:10 Average:96.90 Median:88.00 stddev:15.74 (17.9%) stddev-sans-first:16.42 05:47:24 INFO - PROCESS | 1689 | Values: 105.0 132.0 88.0 86.0 89.0 88.0 90.0 86.0 89.0 116.0 05:47:24 INFO - PROCESS | 1689 | 05:47:24 INFO - PROCESS | 1689 | [#6] imaging-darkroom Cycles:10 Average:120.70 Median:144.00 stddev:20.89 (14.5%) stddev-sans-first:21.59 05:47:24 INFO - PROCESS | 1689 | Values: 134.0 123.0 120.0 109.0 112.0 98.0 154.0 154.0 96.0 107.0 05:47:24 INFO - PROCESS | 1689 | 05:47:24 INFO - PROCESS | 1689 | [#7] imaging-desaturate Cycles:10 Average:97.70 Median:93.50 stddev:13.04 (13.9%) stddev-sans-first:13.76 05:47:24 INFO - PROCESS | 1689 | Values: 94.0 94.0 100.0 134.0 95.0 91.0 94.0 92.0 90.0 93.0 05:47:24 INFO - PROCESS | 1689 | 05:47:24 INFO - PROCESS | 1689 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:58.50 stddev:12.59 (21.5%) stddev-sans-first:13.07 05:47:24 INFO - PROCESS | 1689 | Values: 55.0 59.0 57.0 56.0 58.0 62.0 58.0 66.0 97.0 56.0 05:47:24 INFO - PROCESS | 1689 | 05:47:24 INFO - PROCESS | 1689 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:69.50 stddev:9.41 (13.5%) stddev-sans-first:9.85 05:47:24 INFO - PROCESS | 1689 | Values: 67.0 69.0 65.0 69.0 76.0 70.0 65.0 64.0 72.0 96.0 05:47:24 INFO - PROCESS | 1689 | 05:47:24 INFO - PROCESS | 1689 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.00 stddev:1.81 (2.1%) stddev-sans-first:1.62 05:47:24 INFO - PROCESS | 1689 | Values: 82.0 86.0 84.0 85.0 83.0 87.0 84.0 85.0 88.0 84.0 05:47:24 INFO - PROCESS | 1689 | 05:47:24 INFO - PROCESS | 1689 | [#11] stanford-crypto-ccm Cycles:10 Average:134.70 Median:137.00 stddev:7.79 (5.7%) stddev-sans-first:7.66 05:47:24 INFO - PROCESS | 1689 | Values: 143.0 121.0 140.0 133.0 137.0 127.0 127.0 136.0 146.0 137.0 05:47:24 INFO - PROCESS | 1689 | 05:47:24 INFO - PROCESS | 1689 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.70 Median:142.50 stddev:11.85 (8.3%) stddev-sans-first:11.49 05:47:24 INFO - PROCESS | 1689 | Values: 128.0 142.0 143.0 138.0 138.0 129.0 139.0 143.0 146.0 171.0 05:47:24 INFO - PROCESS | 1689 | 05:47:24 INFO - PROCESS | 1689 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:68.00 stddev:8.82 (13.0%) stddev-sans-first:9.32 05:47:24 INFO - PROCESS | 1689 | Values: 68.0 68.0 68.0 66.0 69.0 95.0 68.0 65.0 69.0 66.0 05:47:24 INFO - PROCESS | 1689 | -------- Summary: end -------- 05:47:24 INFO - PROCESS | 1689 | 05:47:24 INFO - TEST-INFO | 1689: exit 0 05:47:25 INFO - TEST-OK | kraken | took 58453ms 05:47:25 INFO - SUITE-END | took 1170s 05:47:25 INFO - Completed test suite (00:19:30) 05:47:25 INFO - javascript benchmark 05:47:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2915.912522624322, 3497.772644778089, 3525.3301872644197, 3525.7884526928387, 3544.184837487376, 5800.506956908668, 5818.185454036433, 5836.562257830664, 5876.382979787125, 5882.44116808903, 5654.180143879135, 5749.108888122338, 5827.766889324422, 5896.2606031220785, 5991.370906054867, 5216.532028953273, 5225.790968361271, 5268.420473747885, 5338.973305133469, 5351.304330437038, 5325.627206095575, 5361.705106219176, 5387.488188622095, 5403.540699040566, 5409.864753381157, 4443.200223959686, 5066.6200034997155, 5286.841394758163, 5293.417724050351, 5319.0, 5311.990721762852, 5312.76092575835, 5313.840584782462, 5327.094393953037, 5343.412224655285, 5135.486451354872, 5274.235235890813, 5300.946990530122, 5331.493508116722, 5345.5990800689715, 5669.149627555858, 5700.486956173964, 5757.769689212427, 5785.826425207209, 5796.681182534959, 5246.973765131188, 5418.674879507243, 6264.7807326743805, 6264.843378915518, 6296.527760417987, 6156.3843615638525, 6161.599496032743, 6239.594426362272, 6246.250449946036, 6260.248770147611, 5957.314908785458, 5965.373635768268, 5968.31364393096, 5976.462118409364, 6014.75940962361, 6294.0, 6335.841603959938, 6336.904946425807, 6350.301466838644, 6354.205724284465, 6071.726772295257, 6103.792276408673, 6229.813105606839, 6248.281447633581, 6249.281332646713, 6218.751249950042, 6236.469900058455, 6255.593386429959, 6263.96868015657, 6270.404311590391, 6101.368489499298, 6111.713288451782, 6265.624062556261, 6300.558960872695, 6306.211723534559, 5368.899375627987, 6132.263729246545, 6149.2313460817395, 6163.3836616338, 6165.414285642857, 5003.5997120230295, 5007.84976450707, 5010.073136469765, 5017.724025178577, 5039.193729003342, 4426.3581780641625, 4446.644268458515, 4447.888802779892, 4493.820247190141, 4531.980304431542, 5128.999845030258, 5766.0, 5930.673812940329, 6074.210352654215, 6091.725872335755, 6198.504119670415, 6199.256089269226, 6271.059341098871, 6273.62358258506, 6284.780032698925, 5955.106733989936, 6038.758449661965, 6055.333913269536, 6067.217597919783, 6099.512039036867, 5318.095923692981, 5409.594280428983, 5484.369297530835, 5484.396716361197, 5535.418781027934, 6363.268224154282, 6445.581037232565, 6448.548601597843, 6456.709448074754, 6460.676966151674, 6181.165542651865, 6235.875282494416, 6250.937490625036, 6261.812145635638, 6265.0, 6354.555181137276, 6355.3644635536075, 6368.235811702625, 6395.744170233139, 6421.743130274924, 6155.507559395148, 6210.627362358273, 6240.095186198067, 6243.001119820807, 6261.96869015652, 5027.0, 6173.259208894961, 6235.688215589294, 6243.500519958483, 6261.499080073674, 5018.698878067182, 5458.8908221834545, 6084.0, 6131.927227014103, 6282.403171698681, 5490.91763623538, 5994.400559944145, 6222.346653601488, 6233.376662333731, 6270.0, 5965.164876917322, 5993.101034844633, 6082.574219804571, 6089.238845144357, 6183.752649894134, 4989.201727723546, 5704.11586204139, 6103.216452666749, 6171.814845554641, 6185.165002724574, 6093.878122437438, 6115.082737589397, 6125.295591007091, 6152.107944347955, 6163.506919446523], "unit": "score", "name": "dojo.html", "value": 5729.317379677906}, {"lowerIsBetter": false, "replicates": [471.19190588141333, 512.79231911076, 570.287141073658, 593.0067137544612, 642.299893116503, 38666.0, 39097.0, 39100.41349379758, 39107.0, 39179.0205244869, 40680.38979415304, 41003.0, 41052.79473602628, 41464.0, 41518.0, 9437.95281023594, 9738.269629777795, 9746.853797193047, 9757.170640495566, 9771.804563908718, 9621.278404119685, 9718.854217186748, 9735.756606084833, 9757.804843903117, 9783.804323913517, 9743.220542356594, 9763.658271960483, 9766.706998790047, 9776.560054797515, 9825.361351512129, 9738.51307434629, 9784.95107524465, 9788.119069283763, 9806.117449429514, 9853.90146098537, 9549.140577348002, 9671.854922176173, 9679.274054445945, 9698.321117521777, 9716.854247186298, 38902.02744931371, 39171.216575668615, 39186.0, 39329.41005884914, 39520.40719389183, 2632.3682316243962, 3143.229908672367, 3194.6166460024715, 3225.854836532362, 3472.791632502058, 27037.0, 27425.451490970267, 27454.5881811773, 27725.58411623827, 27755.444891102066, 2748.738869807365, 2753.6833264174475, 2758.4069425073703, 2778.2220978126156, 2860.3850172213074, 427420.0, 430124.0, 430254.0, 431169.0, 432163.0, 67134.66432667903, 67487.65024699479, 67712.0, 67805.0, 67843.0, 77148.0, 77351.0, 77504.61247693725, 78397.82403263956, 78542.6072869632, 17008.404705835237, 17115.572110697332, 17130.40043598468, 17255.309787608607, 17273.481795546155, 12357.0, 12395.75208495843, 12834.16577922432, 12907.741845163231, 12922.160059596095, 22304.21935232259, 22506.66240006401, 22743.09027638876, 22832.346824508, 22832.771672283397, 9513.952430237805, 9815.116639502336, 9822.066903644143, 9828.31201815866, 9849.21206303494, 907.1200935093082, 990.8563258327503, 1011.701548043329, 1115.1636272795404, 1180.2564384437921, 29944.850275748482, 30122.84938575337, 30386.240343991576, 30804.845975770426, 30824.383512330078, 1057.8043062033548, 1078.9190810689072, 1102.9007389334838, 1158.976820463586, 1176.8881956214318, 13870.029097963248, 15194.447744643872, 15295.311710973034, 15546.455874044354, 15566.910316277977, 527636.0, 994366.0, 1018174.0, 1020484.0, 1022501.0, 64870.0, 64978.02532962009, 65431.67284163549, 65612.0, 65774.0, 1221.1390969366576, 1423.7721964485634, 1436.4756863744658, 1444.4872070414851, 1453.229788212228, 31103.84448077745, 31447.0, 31678.683213167573, 32050.0, 32265.838670806497, 54013.91972160614, 54102.91794164173, 54225.0, 54858.72570637121, 54999.52502137333, 495742.0, 496804.0, 498422.0, 501497.0, 502115.0, 34290.0, 34804.477932831534, 45301.0, 46223.76888115538, 47375.81560461016, 44150.55849441593, 44498.0, 44500.66498005065, 44509.0, 44668.43660471868, 36845.81577092098, 36856.0, 36911.44632830563, 37141.257174856895, 37430.0, 37646.43530346992, 37858.0, 37905.05237369088, 38630.0, 39201.019974500865, 32684.50973235451, 37846.59380655754, 37964.2407151861, 38427.615723842406, 40055.59944400635, 31918.52122218122, 32297.192570185933, 32701.672983270815, 32850.0, 33289.500657489676, 23432.414189645395, 23456.0, 24383.51232975366, 24481.38796530101, 24764.628530571696], "unit": "score", "name": "ext.html", "value": 20699.76202304072}, {"lowerIsBetter": false, "replicates": [353.14186526740014, 359.9478075679026, 365.2639930539962, 368.5927050609077, 369.63775500010007, 18245.270189192415, 18865.811341886576, 19050.237990480382, 19349.419517414466, 20707.792922070774, 11945.64163075107, 20082.29711960082, 20173.29393471229, 20734.792652073476, 20755.68866467004, 5193.948060519394, 5366.248725178459, 5382.461753824626, 5385.246065550826, 5406.756695948672, 3603.4955106285142, 5346.4118946915805, 5770.624909380897, 6039.456448919596, 6059.272887253535, 6030.457258846703, 6032.095185722133, 6042.637441753487, 6049.909251361233, 6054.6367217966845, 5880.411958804107, 6445.452136568398, 6515.185601799752, 6537.901931471032, 6552.180977377828, 4818.542238487373, 4886.047220791947, 5700.9429905701245, 5715.542756579505, 5737.340205876336, 12499.937500312531, 13218.405171767294, 13238.86761132386, 13243.73512529744, 13279.336033198302, 2108.8945552722457, 2221.688963545105, 2458.2870967419426, 2493.4265119022543, 2512.736162702908, 9459.90540094597, 9994.950025249827, 10101.848472272923, 12242.387880606024, 14611.342489587994, 1708.3679038755615, 1746.8777185597014, 1777.3956854669345, 1816.0919540229886, 1859.8233167849169, 98815.50592247065, 99768.50115749375, 102486.0, 106157.99999999923, 106269.0, 11330.433478326051, 11498.367589782474, 11507.539698411969, 11598.76802463946, 11603.76792464146, 13607.115537490032, 13690.93154534221, 13765.518206862913, 13794.379252933642, 13842.169469831842, 6919.273476285019, 8336.083030866599, 8507.191816777397, 8540.188682075193, 8555.27280181179, 7588.127365352944, 8527.360447966428, 8540.615672294762, 8552.315814734806, 8672.26285765717, 3580.4092324766643, 4479.372887795711, 4521.977390113028, 4565.771711414416, 4596.7931443085145, 1810.0, 1852.2405813616353, 1893.337331933812, 1932.2271091563487, 1944.9124789384512, 817.8999246014101, 861.9827603447895, 903.8373092843351, 1016.9440680762481, 1040.1990467340106, 18788.71816922747, 19778.10998505071, 20086.0, 20288.087036083412, 20403.59192816165, 800.9038915330198, 915.3043686798081, 930.0838673906197, 986.2800155886243, 1017.7150397888603, 10432.321899076536, 10733.570657173626, 10755.677329680122, 10838.496653373082, 10885.346879187275, 621948.5610287769, 633811.0, 640743.0, 661308.0, 664309.3569064247, 85354.0, 107348.46325768321, 111132.0, 112064.43967780271, 114729.4263528677, 915.922146617545, 1032.7314898126692, 1034.446571084466, 1109.0905457524752, 1111.793703831352, 17668.82331176723, 17689.734653980457, 17881.642367152843, 18196.72704909401, 18311.725324120416, 47267.345642902335, 49625.00749985052, 49810.0, 51286.48713512817, 51438.0, 68819.0, 68978.96531551931, 69619.60760784858, 71077.28922710707, 71268.64365678138, 7726.536407815549, 7784.455088143775, 7834.608269586612, 7921.801954950942, 8124.471909325875, 7682.347000505019, 10853.0, 11547.769044618892, 11981.700457488632, 12274.263544187377, 10268.383896966207, 10379.532921018723, 10540.894591053991, 10657.520411581343, 10690.62582809598, 8223.424360294961, 10356.067953883885, 10357.223208259562, 10692.19808514349, 10799.40603266828, 10737.14102871784, 10883.292585982203, 10982.560697572007, 11163.162762792661, 11175.329480231212, 7547.886781698169, 7658.885116723142, 7703.614819258903, 7749.0, 7874.291313781787, 10555.680539932508, 10815.134789217002, 10914.290571112851, 11010.724731881766, 11016.944915275693], "unit": "score", "name": "jquery.html", "value": 9075.137589597174}, {"lowerIsBetter": false, "replicates": [1584.706829236591, 1595.6330044089855, 1885.632301701168, 1975.74315339006, 1993.4717299915517, 8018.358531317495, 8604.741857744262, 8797.032326444094, 8995.640174393024, 9000.324975626829, 8785.0, 8828.690995815148, 8831.470111793296, 8892.822143557125, 8905.821883562325, 2477.1949116537107, 2504.0734928076636, 2509.711383190929, 2512.9748702512925, 2514.1326242446326, 2446.0582675669907, 2472.1223965492263, 2497.5379554782335, 2505.2734706934966, 2530.00064974335, 2482.2925466242123, 2503.0, 2508.272600945733, 2520.269121954631, 2520.281719709883, 2480.6279058141245, 2496.251124662603, 2510.7614776596192, 2521.4578865543904, 2533.4933013397394, 2472.554940110779, 2508.5610018246916, 2515.0065724039086, 2521.596544552881, 2535.632333311678, 8902.42134261271, 8938.955305223431, 9000.819983600357, 9011.909880901172, 9012.504312262823, 5375.784968601251, 5509.283793106871, 5553.194786755938, 5570.6657600544095, 5592.440755924375, 3596.8021758803256, 3686.4101743720876, 3720.7023438125157, 3726.795026273554, 3740.738148329618, 1055.4669891704716, 1072.3297938788257, 1073.2862646340175, 1083.5774048121239, 1085.5169449594855, 10124.493775311204, 11979.820302695467, 12060.819087713691, 12065.034797216202, 12065.215760975596, 4933.45731969483, 4962.5533701967, 4999.75001249936, 5000.024995125916, 5036.697798132123, 10289.639862604923, 10307.742306442398, 10310.793784124275, 10313.329633573794, 10325.48372581368, 5448.0, 5451.836444906659, 5528.143137813645, 5545.584081193927, 5613.859653508695, 4457.7548234846745, 4791.401074865642, 4853.708777473363, 4942.0, 4953.108440480676, 3508.7894726316504, 3530.6936433519763, 4009.4787677602308, 4028.5568587455355, 4038.959610403917, 1167.3054532553117, 1337.2645045225281, 1337.7190789934027, 1347.299404309773, 1361.6051345109806, 1331.380907877822, 1334.6996925691642, 1348.966275843092, 1371.2869307959804, 1385.9307034648227, 8176.713815016446, 8365.372597055246, 8366.498010119412, 8404.033536143299, 8422.747317580483, 519.929809475716, 524.9868753281198, 528.7092099345344, 530.1888111189886, 531.8909623527168, 5099.97450012755, 6292.678537507083, 6329.461995730322, 6329.493640508748, 6381.521385896076, 10459.058684718411, 10715.571377144826, 10807.621733239455, 10833.404162771123, 10862.728431789268, 10671.146308295318, 10687.419454739907, 10699.946500267604, 10744.086752625957, 10800.0, 8486.40595158333, 8491.0, 8492.575371231414, 8512.446690965067, 8531.146885311544, 7912.0901096374655, 7916.525008499278, 7955.721549745963, 7975.2423519765525, 8030.558319292495, 9371.156595906401, 9508.714738557577, 9540.761480963032, 9610.231181505602, 9712.0, 9867.259955503223, 10075.395476271447, 10108.797824043331, 10118.443485608363, 10155.238357123097, 6285.371462853678, 6821.113255276782, 7339.559626422431, 7583.9620801895635, 7639.809004774703, 7051.858962820817, 8417.326613870999, 8462.619182136696, 8481.787955301166, 8491.19333663301, 7447.0, 7591.316781489471, 7638.847223055396, 7647.502912310682, 7697.999260096151, 7391.002214701161, 7403.296686814744, 7429.7399591014055, 7536.886946695914, 7550.66022028999, 7791.4935529190425, 7862.685492580462, 7875.133735288999, 7879.290863822283, 7894.210578942289, 7061.152661680631, 7093.893591596234, 7140.321669441395, 7140.928590714234, 7154.141503019463, 7178.389836863925, 7217.783466496014, 7230.6384680766805, 7267.491275610657, 7276.8908466374105], "unit": "score", "name": "mootools.html", "value": 4914.108331204738}, {"lowerIsBetter": false, "replicates": [327.8426355349432, 328.7632904308898, 332.72051476759515, 336.75080440474056, 338.77870277649083, 5400.8919821603595, 6738.730450781969, 6741.865162696743, 6742.494312926526, 6767.458603311736, 6709.429698475623, 6717.832054198648, 6746.561473504219, 6752.257251702309, 6774.661266936646, 4644.0, 4791.3531673224015, 4943.357363542752, 4973.676711013773, 4973.93581663611, 4263.658907287425, 4948.2824990376375, 4999.175136102539, 5010.123228435027, 5029.371328583927, 4162.0, 4786.545278198583, 4914.557689807916, 4921.040397122562, 4926.778294976717, 4241.384999175133, 4359.8446411700925, 4943.209086546153, 4950.257461380804, 4967.230079337691, 3762.3792074307707, 4241.151769646083, 4242.893927651802, 4255.191513612434, 4261.296886013804, 5159.458256883011, 6089.482393996515, 6484.059811327331, 6495.914440640658, 6541.9345806541805, 5690.772369105272, 5692.203091567142, 5731.168980497804, 5740.655560666373, 5753.510951569122, 7197.992281080653, 7212.819679508002, 7217.8917316240295, 7220.5667659940045, 7234.927650723478, 4581.671315318554, 4593.127305811885, 4595.310703394484, 4599.632029437637, 4616.838410655644, 7614.505057171266, 7651.387888968925, 7662.1954694756805, 7665.731699390551, 7693.153753087156, 4392.3411488277015, 4508.909821803545, 4548.636109111263, 4630.560096790799, 4675.7895894684825, 4752.239641657387, 4767.713937163781, 4768.76156192196, 4771.570558649738, 4786.234202527648, 5648.802291919763, 5655.575831812631, 5701.230333904953, 5704.429557044263, 5707.486326230659, 5785.247917770663, 7263.201047884729, 7270.9636451817405, 7282.4902256841515, 7292.708291668274, 1636.2882146266413, 1651.4467653336267, 1651.9587010324838, 1653.4047742812577, 1664.950051498457, 1026.7843752811843, 1060.2578195263347, 1065.5577935156978, 1070.1224995503612, 1083.4095417997053, 6839.213490448563, 6903.585784852925, 6936.583804971718, 6948.270431604608, 6957.582545047313, 7538.623068846646, 7547.16981132075, 7556.886646700304, 7558.58427786466, 7566.167721550625, 6897.206821215524, 6911.3779759821855, 6914.4468442525485, 6922.06552115468, 6941.375276225164, 3855.132595166121, 3907.4529565860803, 3964.7621142731527, 4017.055991841915, 4020.4773379461067, 7763.650635721406, 7973.322267607318, 8028.036635603765, 8034.638441270157, 8074.515529068275, 7429.21993190718, 7601.745711957576, 7873.0, 7882.330001949784, 7902.328302094386, 7992.68029278834, 7995.0, 8005.199480052064, 8007.279344858991, 8010.919890801018, 5709.858028394421, 6152.938470615237, 7418.548845953951, 7485.214052524407, 7598.20218877032, 6264.874702505833, 7437.628118593941, 7456.6271686414375, 7496.437767167593, 7530.359919406912, 7115.897035959228, 7254.202037775735, 7989.161138080418, 7995.560244186626, 8003.439759216799, 4584.862454126382, 4686.562987246544, 4689.531046895283, 4701.224297990793, 4718.929216061831, 6005.87988240224, 6779.457643388616, 7296.598687072262, 7509.699612015458, 7564.281393267631, 6196.504279657706, 6984.720611175496, 7290.927090729237, 7327.963360183165, 7405.333519983227, 5289.497497737709, 7041.471889608402, 7195.8920616191845, 7345.3021962913435, 7346.081739782528, 7147.8570428592175, 7160.355567998905, 7204.855902882018, 7282.2353652867805, 7314.854612516456, 7128.28717128283, 7325.011123498472, 7357.969884216107, 7361.705531778883, 7382.483226174117, 7097.148342198969, 7121.0, 7172.892406614009, 7187.676554554953, 7223.952526883678], "unit": "score", "name": "prototype.html", "value": 5221.3860460846}, {"lowerIsBetter": false, "replicates": [653.4674240494, 695.1033167214297, 697.139033293882, 731.3381389842191, 755.8677231484493, 14625.488107916211, 14723.190224537646, 14866.0, 14889.404423823034, 14922.477713280037, 13848.584542463743, 13928.860711392883, 15463.922680386611, 15879.444219452322, 15905.44330948417, 931.5435436636034, 950.4867371619317, 951.1772316945827, 952.5665822050985, 953.3850666320219, 750.0549307872093, 930.4463844012802, 936.6440752514069, 942.3686130292687, 954.3891909178096, 988.5106872098321, 992.503748125937, 993.0913214408844, 993.8757655293089, 995.1392045880298, 974.0600320690532, 982.0964712464514, 982.2093214961952, 984.5717113055844, 986.4673076538661, 738.9741359052462, 740.4557650127152, 744.3301029073823, 745.1691364129011, 745.5303159009843, 15147.772783408258, 15317.6170595736, 15372.538823835303, 15591.454299099478, 15611.219439028117, 12395.442205100791, 12510.31193284369, 12586.056045796602, 12616.0, 12734.936325318315, 9944.602215911355, 9978.151857092156, 10145.543450544743, 10159.0, 10378.221633377527, 3419.777714448553, 3439.5356626855305, 3443.2080621456953, 3445.3626079175183, 3452.6202117767025, 55299.61750956258, 78375.6081219596, 82394.17605823986, 83794.32411351739, 85284.72072918911, 9212.585433655502, 9228.630854765868, 9230.815383692288, 9292.39599426035, 9435.0, 21451.356459306247, 21502.354929352143, 21838.126474940826, 21845.67231491529, 21918.123275068818, 7464.365528930101, 7539.208383119803, 7570.735024274124, 7702.152763196044, 7742.380609551223, 4039.3537034074993, 4102.2410853992105, 4102.2821006323775, 4106.527749308868, 4113.4858142732155, 3602.0, 3636.581793093828, 3645.2709458108484, 3653.9817300913323, 3661.2677464507206, 541.5802752866481, 655.4232275597539, 657.2408867757747, 663.3963093584815, 663.548786824954, 523.5942144837782, 575.3527281807966, 580.3963877567282, 599.4694695194784, 610.4688920638984, 6696.59820410777, 7741.4968027079185, 7978.6409611567615, 8064.354851611857, 8125.593720313961, 560.3136158206165, 600.5015836855487, 609.2232403685337, 614.1463365921372, 625.1591609285504, 2802.341449759346, 3576.7138628909624, 3726.627337266306, 3727.3290807654885, 3960.980195099006, 88032.0, 89351.55324223338, 91308.54345728229, 91431.54284228536, 92959.0, 79175.20824791794, 79501.0, 80470.59764701256, 80808.0, 81971.5901420501, 70670.0, 71286.99999999897, 71468.28531714616, 71711.64144179245, 72809.0, 6312.84217894538, 7462.141853686679, 7507.174210836913, 7541.5475071495885, 7597.430192735456, 39722.808315750575, 51538.96922061613, 51977.7401112992, 52350.21474677959, 52359.73820130875, 65068.34931650812, 66516.6674166626, 68573.65713171402, 72748.0, 73559.26440735524, 9845.704628861145, 9847.950760246153, 9893.258005649748, 9985.101340879355, 10037.197024237897, 8670.263027642468, 8714.91285087141, 10636.574537018432, 11037.227394082338, 11118.332900026024, 8227.79430514218, 8556.914430855611, 10054.8491772622, 10337.844932326172, 10395.740106497096, 8061.516309021477, 9724.562394692115, 10027.649032284127, 10060.748481287734, 10334.224933130195, 9719.27105467107, 9768.267379946674, 9941.403515789076, 10046.296759226783, 10164.949175254076, 8570.78573035679, 8832.558372081241, 8879.689210877588, 8897.955510222408, 8976.102389760972, 7944.563049032358, 8565.657373704982, 9317.928438229419, 9648.75878103053, 9655.855162172713], "unit": "score", "name": "yui.html", "value": 6736.899444602361}], "name": "dromaeo_css", "value": 7555.698797653375}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 111.0, 115.0, 114.0, 115.0, 127.0, 115.0, 114.0, 115.0, 118.0], "unit": "score", "name": "ai-astar", "value": 115.9}, {"lowerIsBetter": true, "replicates": [151.0, 119.0, 143.0, 149.0, 118.0, 138.0, 139.0, 120.0, 161.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 135.6}, {"lowerIsBetter": true, "replicates": [191.0, 192.0, 198.0, 194.0, 205.0, 220.0, 211.0, 201.0, 199.0, 196.0], "unit": "score", "name": "audio-dft", "value": 200.7}, {"lowerIsBetter": true, "replicates": [64.0, 79.0, 59.0, 76.0, 85.0, 84.0, 90.0, 125.0, 56.0, 55.0], "unit": "score", "name": "audio-fft", "value": 77.3}, {"lowerIsBetter": true, "replicates": [79.0, 89.0, 120.0, 79.0, 79.0, 80.0, 119.0, 81.0, 79.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 92.1}, {"lowerIsBetter": true, "replicates": [105.0, 132.0, 88.0, 86.0, 89.0, 88.0, 90.0, 86.0, 89.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 96.9}, {"lowerIsBetter": true, "replicates": [134.0, 123.0, 120.0, 109.0, 112.0, 98.0, 154.0, 154.0, 96.0, 107.0], "unit": "score", "name": "imaging-darkroom", "value": 120.7}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 100.0, 134.0, 95.0, 91.0, 94.0, 92.0, 90.0, 93.0], "unit": "score", "name": "imaging-desaturate", "value": 97.7}, {"lowerIsBetter": true, "replicates": [55.0, 59.0, 57.0, 56.0, 58.0, 62.0, 58.0, 66.0, 97.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 62.4}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 65.0, 69.0, 76.0, 70.0, 65.0, 64.0, 72.0, 96.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.3}, {"lowerIsBetter": true, "replicates": [82.0, 86.0, 84.0, 85.0, 83.0, 87.0, 84.0, 85.0, 88.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [143.0, 121.0, 140.0, 133.0, 137.0, 127.0, 127.0, 136.0, 146.0, 137.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 134.7}, {"lowerIsBetter": true, "replicates": [128.0, 142.0, 143.0, 138.0, 138.0, 129.0, 139.0, 143.0, 146.0, 171.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 66.0, 69.0, 95.0, 68.0, 65.0, 69.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.2}], "name": "kraken", "value": 1502.0000000000002}]} 05:47:25 INFO - Return code: 0 05:47:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:47:25 ERROR - # TBPL SUCCESS # 05:47:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:47:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:47:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:47:25 INFO - 2016-03-13 05:47:25.621 screenresolution[1694:10540] starting screenresolution argv=screenresolution get 05:47:25 INFO - 2016-03-13 05:47:25.623 screenresolution[1694:10540] Display 0: 1600x1200x32@60 05:47:25 INFO - 2016-03-13 05:47:25.629 screenresolution[1695:10543] starting screenresolution argv=screenresolution list 05:47:25 INFO - Available Modes on Display 0 05:47:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:47:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:47:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:47:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:47:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:47:25 INFO - Intel Iris: 05:47:25 INFO - Chipset Model: Intel Iris 05:47:25 INFO - Type: GPU 05:47:25 INFO - Bus: Built-In 05:47:25 INFO - VRAM (Dynamic, Max): 1536 MB 05:47:25 INFO - Vendor: Intel (0x8086) 05:47:25 INFO - Device ID: 0x0a2e 05:47:25 INFO - Revision ID: 0x0009 05:47:25 INFO - Displays: 05:47:25 INFO - Display: 05:47:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:47:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:47:25 INFO - Display Serial Number: 1600x1200 60 05:47:25 INFO - Main Display: Yes 05:47:25 INFO - Mirror: Off 05:47:25 INFO - Online: Yes 05:47:25 INFO - Rotation: Supported 05:47:25 INFO - Return code: 0 05:47:25 INFO - Running post-action listener: _resource_record_post_action 05:47:25 INFO - Running post-run listener: _resource_record_post_run 05:47:26 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 35126784; Write bytes: 710030848; Read time: 370; Write time: 2359 05:47:26 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 399874560; Write bytes: 393754624; Read time: 30357; Write time: 971 05:47:26 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 33340928; Write bytes: 305274368; Read time: 351; Write time: 1344 05:47:26 INFO - Running post-run listener: _upload_blobber_files 05:47:26 INFO - Blob upload gear active. 05:47:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:47:26 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:47:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:47:27 INFO - (blobuploader) - INFO - Open directory for files ... 05:47:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:47:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:47:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:28 INFO - (blobuploader) - INFO - Done attempting. 05:47:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:47:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:47:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:29 INFO - (blobuploader) - INFO - Done attempting. 05:47:29 INFO - (blobuploader) - INFO - Iteration through files over. 05:47:29 INFO - Return code: 0 05:47:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:47:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:47:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4301b8b721cf4765543ac91464bd01d8028da8e2bcb91dc5155f159715d715ef60b33909063a167e34811e0df5f33025835ac11023f429edee9837bd8a133be7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e8e0e2dac1c59a97c912caef18c95a01e92b9a4ef116ebda49db179d6c71a854aac55cff6a97fb4f9d8ef22b16bf3c23a38f5d5f48069bd7507fd11187bfe2e"} 05:47:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:47:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:47:29 INFO - Contents: 05:47:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4301b8b721cf4765543ac91464bd01d8028da8e2bcb91dc5155f159715d715ef60b33909063a167e34811e0df5f33025835ac11023f429edee9837bd8a133be7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e8e0e2dac1c59a97c912caef18c95a01e92b9a4ef116ebda49db179d6c71a854aac55cff6a97fb4f9d8ef22b16bf3c23a38f5d5f48069bd7507fd11187bfe2e"} 05:47:29 INFO - Running post-run listener: copy_logs_to_upload_dir 05:47:29 INFO - Copying logs to upload dir... 05:47:29 INFO - mkdir: /builds/slave/test/build/upload/logs 05:47:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1339.853620 ========= master_lag: 1.73 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 21 secs) (at 2016-03-13 05:47:30.775565) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-13 05:47:30.781389) ========= 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.ndQtWxRqSY/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.k4Fb4cjy0J/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4301b8b721cf4765543ac91464bd01d8028da8e2bcb91dc5155f159715d715ef60b33909063a167e34811e0df5f33025835ac11023f429edee9837bd8a133be7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e8e0e2dac1c59a97c912caef18c95a01e92b9a4ef116ebda49db179d6c71a854aac55cff6a97fb4f9d8ef22b16bf3c23a38f5d5f48069bd7507fd11187bfe2e"} build_url:https://queue.taskcluster.net/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011150 build_url: 'https://queue.taskcluster.net/v1/task/cnOlZjC_TIyD5ulLq98jXQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4301b8b721cf4765543ac91464bd01d8028da8e2bcb91dc5155f159715d715ef60b33909063a167e34811e0df5f33025835ac11023f429edee9837bd8a133be7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e8e0e2dac1c59a97c912caef18c95a01e92b9a4ef116ebda49db179d6c71a854aac55cff6a97fb4f9d8ef22b16bf3c23a38f5d5f48069bd7507fd11187bfe2e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-13 05:47:30.818348) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 05:47:30.818757) ========= 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.ndQtWxRqSY/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.k4Fb4cjy0J/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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.005249 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 05:47:30.871556) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-13 05:47:30.872004) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-13 05:47:30.873053) ========= ========= Total master_lag: 2.17 =========