builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0060 starttime: 1457808603.16 results: success (0) buildid: 20160312100030 builduid: 5558b1c511164138a3b13726d334d26d revision: b8efc6dc729ea6b1b5de4e6aca866ee52d7dccf9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-12 10:50:03.162514) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-12 10:50:03.163144) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-12 10:50:03.163437) ========= 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.7jdLhr7WUO/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.M9h9F3iPKe/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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.005457 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-12 10:50:03.207514) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-12 10:50:03.207884) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-12 10:50:03.386770) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 10:50:03.387101) ========= 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.7jdLhr7WUO/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.M9h9F3iPKe/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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.005789 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 10:50:03.450203) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-12 10:50:03.450463) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-12 10:50:03.450781) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 10:50:03.451105) ========= 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.7jdLhr7WUO/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.M9h9F3iPKe/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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-12 10:50:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 70.2M=0s 2016-03-12 10:50:03 (70.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.143304 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 10:50:03.657761) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 10:50:03.658066) ========= 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.7jdLhr7WUO/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.M9h9F3iPKe/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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.025860 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 10:50:03.751496) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-12 10:50:03.751856) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b8efc6dc729ea6b1b5de4e6aca866ee52d7dccf9 --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 b8efc6dc729ea6b1b5de4e6aca866ee52d7dccf9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7jdLhr7WUO/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.M9h9F3iPKe/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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-12 10:50:03,837 truncating revision to first 12 chars 2016-03-12 10:50:03,837 Setting DEBUG logging. 2016-03-12 10:50:03,837 attempt 1/10 2016-03-12 10:50:03,837 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b8efc6dc729e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-12 10:50:04,695 unpacking tar archive at: mozilla-central-b8efc6dc729e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.107704 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-12 10:50:04.890180) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-12 10:50:04.890518) ========= echo b8efc6dc729ea6b1b5de4e6aca866ee52d7dccf9 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b8efc6dc729ea6b1b5de4e6aca866ee52d7dccf9'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7jdLhr7WUO/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.M9h9F3iPKe/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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 b8efc6dc729ea6b1b5de4e6aca866ee52d7dccf9 program finished with exit code 0 elapsedTime=0.005943 script_repo_revision: 'b8efc6dc729ea6b1b5de4e6aca866ee52d7dccf9' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-12 10:50:04.940252) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-12 10:50:04.940537) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-12 10:50:04.958262) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 35 secs) (at 2016-03-12 10:50:04.958561) ========= /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.7jdLhr7WUO/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.M9h9F3iPKe/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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 10:50:05 INFO - MultiFileLogger online at 20160312 10:50:05 in /builds/slave/test 10:50:05 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 10:50:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:50:05 INFO - {'append_to_log': False, 10:50:05 INFO - 'base_work_dir': '/builds/slave/test', 10:50:05 INFO - 'blob_upload_branch': 'Firefox', 10:50:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:50:05 INFO - 'branch': 'Firefox', 10:50:05 INFO - 'buildbot_json_path': 'buildprops.json', 10:50:05 INFO - 'config_files': ('talos/mac_config.py',), 10:50:05 INFO - 'default_actions': ('clobber', 10:50:05 INFO - 'read-buildbot-config', 10:50:05 INFO - 'download-and-extract', 10:50:05 INFO - 'populate-webroot', 10:50:05 INFO - 'create-virtualenv', 10:50:05 INFO - 'install', 10:50:05 INFO - 'run-tests'), 10:50:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:50:05 INFO - 'download_minidump_stackwalk': True, 10:50:05 INFO - 'download_symbols': 'ondemand', 10:50:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:50:05 INFO - 'tooltool.py': '/tools/tooltool.py', 10:50:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:50:05 INFO - '/tools/misc-python/virtualenv.py')}, 10:50:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:50:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:50:05 INFO - 'installer_path': 'installer.exe', 10:50:05 INFO - 'log_level': 'info', 10:50:05 INFO - 'log_name': 'talos', 10:50:05 INFO - 'log_to_console': True, 10:50:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:50:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:50:05 INFO - 'opt_config_files': (), 10:50:05 INFO - 'pip_index': False, 10:50:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:50:05 INFO - 'cmd': ('bash', 10:50:05 INFO - '-c', 10:50:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:50:05 INFO - 'enabled': True, 10:50:05 INFO - 'halt_on_failure': False, 10:50:05 INFO - 'name': 'check_screen_resolution'},), 10:50:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:50:05 INFO - 'cmd': ('bash', 10:50:05 INFO - '-c', 10:50:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:50:05 INFO - 'enabled': True, 10:50:05 INFO - 'halt_on_failure': False, 10:50:05 INFO - 'name': 'check_screen_resolution'},), 10:50:05 INFO - 'run_cmd_checks_enabled': True, 10:50:05 INFO - 'sps_profile': False, 10:50:05 INFO - 'sps_profile_interval': 0, 10:50:05 INFO - 'suite': 'dromaeojs-e10s', 10:50:05 INFO - 'system_bits': '32', 10:50:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:50:05 INFO - 'title': 't-yosemite-r7-0060', 10:50:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:50:05 INFO - 'use_talos_json': True, 10:50:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:50:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:50:05 INFO - 'work_dir': 'build'} 10:50:05 INFO - ##### 10:50:05 INFO - ##### Running clobber step. 10:50:05 INFO - ##### 10:50:05 INFO - Running pre-action listener: _resource_record_pre_action 10:50:05 INFO - Running main action method: clobber 10:50:05 INFO - rmtree: /builds/slave/test/build 10:50:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:50:06 INFO - Running post-action listener: _resource_record_post_action 10:50:06 INFO - ##### 10:50:06 INFO - ##### Running read-buildbot-config step. 10:50:06 INFO - ##### 10:50:06 INFO - Running pre-action listener: _resource_record_pre_action 10:50:06 INFO - Running main action method: read_buildbot_config 10:50:06 INFO - Using buildbot properties: 10:50:06 INFO - { 10:50:06 INFO - "project": "", 10:50:06 INFO - "product": "firefox", 10:50:06 INFO - "script_repo_revision": "production", 10:50:06 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 10:50:06 INFO - "repository": "", 10:50:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 10:50:06 INFO - "buildid": "20160312100030", 10:50:06 INFO - "pgo_build": "False", 10:50:06 INFO - "basedir": "/builds/slave/test", 10:50:06 INFO - "buildnumber": 187, 10:50:06 INFO - "slavename": "t-yosemite-r7-0060", 10:50:06 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 10:50:06 INFO - "platform": "yosemite_r7", 10:50:06 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:50:06 INFO - "branch": "mozilla-central", 10:50:06 INFO - "repo_path": "mozilla-central", 10:50:06 INFO - "revision": "b8efc6dc729ea6b1b5de4e6aca866ee52d7dccf9", 10:50:06 INFO - "stage_platform": "macosx64", 10:50:06 INFO - "builduid": "5558b1c511164138a3b13726d334d26d", 10:50:06 INFO - "slavebuilddir": "test" 10:50:06 INFO - } 10:50:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/G1WF6RILS7-vygX84T-eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 10:50:06 INFO - Running post-action listener: _resource_record_post_action 10:50:06 INFO - ##### 10:50:06 INFO - ##### Running download-and-extract step. 10:50:06 INFO - ##### 10:50:06 INFO - Running pre-action listener: _resource_record_pre_action 10:50:06 INFO - Running main action method: download_and_extract 10:50:06 INFO - mkdir: /builds/slave/test/build/tests 10:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:50:06 INFO - https://queue.taskcluster.net/v1/task/G1WF6RILS7-vygX84T-eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:50:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1WF6RILS7-vygX84T-eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 10:50:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1WF6RILS7-vygX84T-eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 10:50:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1WF6RILS7-vygX84T-eAA/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 10:50:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1WF6RILS7-vygX84T-eAA/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 10:50:37 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1WF6RILS7-vygX84T-eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json: timed out 10:50:37 INFO - retry: attempt #1 caught exception: timed out 10:50:37 INFO - retry: Failed, sleeping 30 seconds before retrying 10:51:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1WF6RILS7-vygX84T-eAA/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 10:51:35 INFO - Downloaded 1199 bytes. 10:51:35 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 10:51:35 INFO - Using the following test package requirements: 10:51:35 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 10:51:35 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:51:35 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 10:51:35 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:51:35 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 10:51:35 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:51:35 INFO - u'jsshell-mac.zip'], 10:51:35 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:51:35 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 10:51:35 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 10:51:35 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:51:35 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 10:51:35 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:51:35 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 10:51:35 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:51:35 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 10:51:35 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:51:35 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 10:51:35 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:35 INFO - https://queue.taskcluster.net/v1/task/G1WF6RILS7-vygX84T-eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:51:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1WF6RILS7-vygX84T-eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:51:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1WF6RILS7-vygX84T-eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:51:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1WF6RILS7-vygX84T-eAA/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 10:51:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1WF6RILS7-vygX84T-eAA/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 10:51:36 INFO - Downloaded 17865112 bytes. 10:51:36 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'] 10:51:36 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 10:51:39 INFO - Return code: 0 10:51:39 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 10:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:39 INFO - https://queue.taskcluster.net/v1/task/G1WF6RILS7-vygX84T-eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:51:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1WF6RILS7-vygX84T-eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:51:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1WF6RILS7-vygX84T-eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:51:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1WF6RILS7-vygX84T-eAA/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 10:51:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1WF6RILS7-vygX84T-eAA/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 10:51:41 INFO - Downloaded 17865112 bytes. 10:51:41 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'] 10:51:41 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 10:51:44 INFO - Return code: 0 10:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:44 INFO - https://queue.taskcluster.net/v1/task/G1WF6RILS7-vygX84T-eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:51:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1WF6RILS7-vygX84T-eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 10:51:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1WF6RILS7-vygX84T-eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 10:51:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1WF6RILS7-vygX84T-eAA/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 10:51:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1WF6RILS7-vygX84T-eAA/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 10:51:45 INFO - Downloaded 10845263 bytes. 10:51:45 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'] 10:51:45 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 10:51:46 INFO - Return code: 0 10:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:46 INFO - https://queue.taskcluster.net/v1/task/G1WF6RILS7-vygX84T-eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:51:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1WF6RILS7-vygX84T-eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 10:51:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1WF6RILS7-vygX84T-eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 10:51:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1WF6RILS7-vygX84T-eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 10:51:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1WF6RILS7-vygX84T-eAA/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 10:51:53 INFO - Downloaded 111014984 bytes. 10:51:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G1WF6RILS7-vygX84T-eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 10:51:53 INFO - mkdir: /builds/slave/test/properties 10:51:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:51:53 INFO - Writing to file /builds/slave/test/properties/build_url 10:51:53 INFO - Contents: 10:51:53 INFO - build_url:https://queue.taskcluster.net/v1/task/G1WF6RILS7-vygX84T-eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 10:51:54 INFO - Running post-action listener: _resource_record_post_action 10:51:54 INFO - Running post-action listener: set_extra_try_arguments 10:51:54 INFO - ##### 10:51:54 INFO - ##### Running populate-webroot step. 10:51:54 INFO - ##### 10:51:54 INFO - Running pre-action listener: _resource_record_pre_action 10:51:54 INFO - Running main action method: populate_webroot 10:51:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:51:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:51:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:51:54 INFO - '--tppagecycles', 10:51:54 INFO - '7'], 10:51:54 INFO - 'tests': ['tsvgm']}}, 10:51:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:51:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:51:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:51:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:51:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:51:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:51:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:51:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:54 INFO - 'talos_options': ['--e10s'], 10:51:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:51:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:54 INFO - 'tests': ['damp', 'tps']}, 10:51:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:54 INFO - 'talos_options': ['--e10s'], 10:51:54 INFO - 'tests': ['damp', 'tps']}, 10:51:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:51:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:51:54 INFO - 'other': {'tests': ['a11yr', 10:51:54 INFO - 'ts_paint', 10:51:54 INFO - 'tpaint', 10:51:54 INFO - 'sessionrestore', 10:51:54 INFO - 'sessionrestore_no_auto_restore', 10:51:54 INFO - 'tabpaint']}, 10:51:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:51:54 INFO - 'tests': ['a11yr', 10:51:54 INFO - 'ts_paint', 10:51:54 INFO - 'tpaint', 10:51:54 INFO - 'sessionrestore', 10:51:54 INFO - 'sessionrestore_no_auto_restore', 10:51:54 INFO - 'tabpaint']}, 10:51:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:51:54 INFO - 'tests': ['a11yr', 10:51:54 INFO - 'ts_paint', 10:51:54 INFO - 'tpaint', 10:51:54 INFO - 'sessionrestore', 10:51:54 INFO - 'sessionrestore_no_auto_restore', 10:51:54 INFO - 'tabpaint']}, 10:51:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:51:54 INFO - 'tests': ['a11yr', 10:51:54 INFO - 'ts_paint', 10:51:54 INFO - 'tpaint', 10:51:54 INFO - 'sessionrestore', 10:51:54 INFO - 'sessionrestore_no_auto_restore', 10:51:54 INFO - 'tabpaint']}, 10:51:54 INFO - 'other_l64': {'tests': ['a11yr', 10:51:54 INFO - 'ts_paint', 10:51:54 INFO - 'tpaint', 10:51:54 INFO - 'sessionrestore', 10:51:54 INFO - 'sessionrestore_no_auto_restore', 10:51:54 INFO - 'tabpaint']}, 10:51:54 INFO - 'other_nol64': {'tests': ['a11yr', 10:51:54 INFO - 'ts_paint', 10:51:54 INFO - 'tpaint', 10:51:54 INFO - 'sessionrestore', 10:51:54 INFO - 'sessionrestore_no_auto_restore', 10:51:54 INFO - 'tabpaint']}, 10:51:54 INFO - 'svgr': {'tests': ['tsvgx', 10:51:54 INFO - 'tsvgr_opacity', 10:51:54 INFO - 'tart', 10:51:54 INFO - 'tscrollx', 10:51:54 INFO - 'cart']}, 10:51:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:51:54 INFO - 'tests': ['tsvgx', 10:51:54 INFO - 'tsvgr_opacity', 10:51:54 INFO - 'tart', 10:51:54 INFO - 'tscrollx', 10:51:54 INFO - 'cart']}, 10:51:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:54 INFO - 'tests': ['tp5o']}, 10:51:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:54 INFO - 'talos_options': ['--e10s'], 10:51:54 INFO - 'tests': ['tp5o']}, 10:51:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:54 INFO - 'talos_options': ['--xperf_path', 10:51:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:51:54 INFO - 'tests': ['tp5n']}, 10:51:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:54 INFO - 'talos_options': ['--e10s', 10:51:54 INFO - '--xperf_path', 10:51:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:51:54 INFO - 'tests': ['tp5n']}}, 10:51:54 INFO - 'talos.zip': {'path': '', 10:51:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:51:54 INFO - Running post-action listener: _resource_record_post_action 10:51:54 INFO - ##### 10:51:54 INFO - ##### Running create-virtualenv step. 10:51:54 INFO - ##### 10:51:54 INFO - Running pre-action listener: _resource_record_pre_action 10:51:54 INFO - Running main action method: create_virtualenv 10:51:54 INFO - Creating virtualenv /builds/slave/test/build/venv 10:51:54 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 10:51:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:51:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:51:54 INFO - Using real prefix '/tools/python27' 10:51:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:51:55 INFO - Installing distribute.............................................................................................................................................................................................done. 10:51:58 INFO - Installing pip.................done. 10:51:58 INFO - Return code: 0 10:51:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da8ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da924c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab40585700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d92fd30>, '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 0x10d753db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d926b20>, '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.7jdLhr7WUO/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.M9h9F3iPKe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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 10:51:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:51:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:51:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7jdLhr7WUO/Render', 10:51:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:58 INFO - 'HOME': '/Users/cltbld', 10:51:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:58 INFO - 'LOGNAME': 'cltbld', 10:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:58 INFO - 'MOZ_NO_REMOTE': '1', 10:51:58 INFO - 'NO_EM_RESTART': '1', 10:51:58 INFO - 'PAGER': '/bin/cat', 10:51:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:58 INFO - 'PWD': '/builds/slave/test', 10:51:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:58 INFO - 'SHELL': '/bin/bash', 10:51:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M9h9F3iPKe/Listeners', 10:51:58 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 10:51:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:58 INFO - 'USER': 'cltbld', 10:51:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:58 INFO - 'XPC_FLAGS': '0x0', 10:51:58 INFO - 'XPC_SERVICE_NAME': '0', 10:51:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:58 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 10:51:58 INFO - Cleaning up... 10:51:58 INFO - Return code: 0 10:51:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10da8ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da924c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab40585700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d92fd30>, '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 0x10d753db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d926b20>, '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.7jdLhr7WUO/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.M9h9F3iPKe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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 10:51:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:51:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:51:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7jdLhr7WUO/Render', 10:51:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:51:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:51:58 INFO - 'HOME': '/Users/cltbld', 10:51:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:51:58 INFO - 'LOGNAME': 'cltbld', 10:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:58 INFO - 'MOZ_NO_REMOTE': '1', 10:51:58 INFO - 'NO_EM_RESTART': '1', 10:51:58 INFO - 'PAGER': '/bin/cat', 10:51:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:58 INFO - 'PWD': '/builds/slave/test', 10:51:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:51:58 INFO - 'SHELL': '/bin/bash', 10:51:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M9h9F3iPKe/Listeners', 10:51:58 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 10:51:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:51:58 INFO - 'USER': 'cltbld', 10:51:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:51:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:58 INFO - 'XPC_FLAGS': '0x0', 10:51:58 INFO - 'XPC_SERVICE_NAME': '0', 10:51:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:51:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:59 INFO - Downloading/unpacking psutil>=0.7.1 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:52:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:52:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:52:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:52:02 INFO - Installing collected packages: psutil 10:52:02 INFO - Running setup.py install for psutil 10:52:02 INFO - building 'psutil._psutil_osx' extension 10:52:02 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 10:52:02 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 10:52:03 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 10:52:03 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 10:52:03 INFO - building 'psutil._psutil_posix' extension 10:52:03 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 10:52:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:52:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:52:03 INFO - ^ 10:52:03 INFO - 1 warning generated. 10:52:03 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 10:52:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:52:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:52:03 INFO - Successfully installed psutil 10:52:03 INFO - Cleaning up... 10:52:03 INFO - Return code: 0 10:52:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:52:03 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')]} 10:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:03 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')]} 10:52:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:03 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 0x10da8ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da924c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab40585700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d92fd30>, '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 0x10d753db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d926b20>, '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.7jdLhr7WUO/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.M9h9F3iPKe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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 10:52:03 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 10:52:03 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 10:52:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7jdLhr7WUO/Render', 10:52:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:03 INFO - 'HOME': '/Users/cltbld', 10:52:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:03 INFO - 'LOGNAME': 'cltbld', 10:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:03 INFO - 'MOZ_NO_REMOTE': '1', 10:52:03 INFO - 'NO_EM_RESTART': '1', 10:52:03 INFO - 'PAGER': '/bin/cat', 10:52:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:03 INFO - 'PWD': '/builds/slave/test', 10:52:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:03 INFO - 'SHELL': '/bin/bash', 10:52:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M9h9F3iPKe/Listeners', 10:52:03 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 10:52:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:03 INFO - 'USER': 'cltbld', 10:52:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:03 INFO - 'XPC_FLAGS': '0x0', 10:52:03 INFO - 'XPC_SERVICE_NAME': '0', 10:52:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:52:03 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 10:52:03 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 10:52:03 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 10:52:03 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 10:52:03 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 10:52:03 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 10:52:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:52:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:52:06 INFO - Installing collected packages: mozsystemmonitor 10:52:06 INFO - Running setup.py install for mozsystemmonitor 10:52:06 INFO - Successfully installed mozsystemmonitor 10:52:06 INFO - Cleaning up... 10:52:06 INFO - Return code: 0 10:52:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:52:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:06 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 0x10da8ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da924c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab40585700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d92fd30>, '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 0x10d753db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d926b20>, '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.7jdLhr7WUO/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.M9h9F3iPKe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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 10:52:06 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 10:52:06 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 10:52:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7jdLhr7WUO/Render', 10:52:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:06 INFO - 'HOME': '/Users/cltbld', 10:52:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:06 INFO - 'LOGNAME': 'cltbld', 10:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:06 INFO - 'MOZ_NO_REMOTE': '1', 10:52:06 INFO - 'NO_EM_RESTART': '1', 10:52:06 INFO - 'PAGER': '/bin/cat', 10:52:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:06 INFO - 'PWD': '/builds/slave/test', 10:52:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:06 INFO - 'SHELL': '/bin/bash', 10:52:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M9h9F3iPKe/Listeners', 10:52:06 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 10:52:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:06 INFO - 'USER': 'cltbld', 10:52:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:06 INFO - 'XPC_FLAGS': '0x0', 10:52:06 INFO - 'XPC_SERVICE_NAME': '0', 10:52:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:06 INFO - Downloading/unpacking blobuploader==1.2.4 10:52:06 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 10:52:06 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 10:52:06 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 10:52:06 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 10:52:06 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 10:52:06 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 10:52:09 INFO - Downloading blobuploader-1.2.4.tar.gz 10:52:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:52:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:52:09 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 10:52:09 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 10:52:09 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 10:52:09 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 10:52:09 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 10:52:09 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 10:52:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:52:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:52:09 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 10:52:09 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 10:52:09 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 10:52:09 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 10:52:09 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 10:52:09 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 10:52:10 INFO - Downloading docopt-0.6.1.tar.gz 10:52:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:52:10 INFO - Installing collected packages: blobuploader, requests, docopt 10:52:10 INFO - Running setup.py install for blobuploader 10:52:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:52:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:52:10 INFO - Running setup.py install for requests 10:52:10 INFO - Running setup.py install for docopt 10:52:11 INFO - Successfully installed blobuploader requests docopt 10:52:11 INFO - Cleaning up... 10:52:11 INFO - Return code: 0 10:52:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52: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')]} 10:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52: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')]} 10:52:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:11 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 0x10da8ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da924c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab40585700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d92fd30>, '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 0x10d753db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d926b20>, '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.7jdLhr7WUO/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.M9h9F3iPKe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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 10:52:11 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 10:52:11 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 10:52:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7jdLhr7WUO/Render', 10:52:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:11 INFO - 'HOME': '/Users/cltbld', 10:52:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:11 INFO - 'LOGNAME': 'cltbld', 10:52:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:11 INFO - 'MOZ_NO_REMOTE': '1', 10:52:11 INFO - 'NO_EM_RESTART': '1', 10:52:11 INFO - 'PAGER': '/bin/cat', 10:52:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:11 INFO - 'PWD': '/builds/slave/test', 10:52:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:11 INFO - 'SHELL': '/bin/bash', 10:52:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M9h9F3iPKe/Listeners', 10:52:11 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 10:52:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:11 INFO - 'USER': 'cltbld', 10:52:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:11 INFO - 'XPC_FLAGS': '0x0', 10:52:11 INFO - 'XPC_SERVICE_NAME': '0', 10:52:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:52:11 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-jnevem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:52:11 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-NveQKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:52:11 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-TC9nwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:52:11 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-dodP_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:52:11 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-LPggtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:52:11 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-i1uAT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:52:11 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-cgt57R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:52:12 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-hr8NhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:52:12 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-F_x3od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:52:12 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-I6H0Av-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:52:12 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-Wyywc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:52:12 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-So6YhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:52:12 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-JTBfZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:52:12 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-1gMJy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:12 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-WuRRDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:52:12 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-sJAF2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:52:13 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-RSUWXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:52:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:52:13 INFO - Running setup.py install for manifestparser 10:52:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:52:13 INFO - Running setup.py install for mozcrash 10:52:13 INFO - Running setup.py install for mozdebug 10:52:13 INFO - Running setup.py install for mozdevice 10:52:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:52:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:52:13 INFO - Running setup.py install for mozfile 10:52:13 INFO - Running setup.py install for mozhttpd 10:52:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:52:13 INFO - Running setup.py install for mozinfo 10:52:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:52:14 INFO - Running setup.py install for mozInstall 10:52:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:52:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:52:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:52:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:52:14 INFO - Running setup.py install for mozleak 10:52:14 INFO - Running setup.py install for mozlog 10:52:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:52:14 INFO - Running setup.py install for moznetwork 10:52:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:52:14 INFO - Running setup.py install for mozprocess 10:52:14 INFO - Running setup.py install for mozprofile 10:52:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:52:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:52:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:52:15 INFO - Running setup.py install for mozrunner 10:52:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:52:15 INFO - Running setup.py install for mozscreenshot 10:52:15 INFO - Running setup.py install for moztest 10:52:15 INFO - Running setup.py install for mozversion 10:52:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:52:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:52:15 INFO - Cleaning up... 10:52:15 INFO - Return code: 0 10:52:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:15 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 0x10da8ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da924c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab40585700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d92fd30>, '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 0x10d753db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d926b20>, '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.7jdLhr7WUO/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.M9h9F3iPKe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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 10:52:15 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 10:52:15 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 10:52:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7jdLhr7WUO/Render', 10:52:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:15 INFO - 'HOME': '/Users/cltbld', 10:52:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:15 INFO - 'LOGNAME': 'cltbld', 10:52:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:15 INFO - 'MOZ_NO_REMOTE': '1', 10:52:15 INFO - 'NO_EM_RESTART': '1', 10:52:15 INFO - 'PAGER': '/bin/cat', 10:52:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:15 INFO - 'PWD': '/builds/slave/test', 10:52:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:15 INFO - 'SHELL': '/bin/bash', 10:52:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M9h9F3iPKe/Listeners', 10:52:15 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 10:52:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:15 INFO - 'USER': 'cltbld', 10:52:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:15 INFO - 'XPC_FLAGS': '0x0', 10:52:15 INFO - 'XPC_SERVICE_NAME': '0', 10:52:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:52:15 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-jlxtcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:52:16 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)) 10:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:52:16 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-fgBqH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:52:16 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)) 10:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:52:16 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-IYYmOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:52:16 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)) 10:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:52:16 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-od6guF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:52:16 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)) 10:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:52:16 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-oS5iBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:52:16 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)) 10:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:52:16 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-wh8l4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:52:16 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)) 10:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:52:16 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-S0QhEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:52:16 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)) 10:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:52:16 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-q2ecTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:52:16 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)) 10:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:52:16 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-WBljV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:52:16 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)) 10:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:52:16 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-jj4tpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:52:16 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)) 10:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:52:16 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-K_297W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:52:17 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)) 10:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:52:17 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-xUtNiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:52:17 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)) 10:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:52:17 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-iHblBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:52:17 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)) 10:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:52:17 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-f9jzRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:52:17 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)) 10:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:17 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-5eKTO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:17 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)) 10:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:52:17 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-Brl9w9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:52:17 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)) 10:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:52:17 INFO - Running setup.py (path:/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/pip-EaVg1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:52:17 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)) 10:52:17 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)) 10:52:17 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)) 10:52:17 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)) 10:52:17 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)) 10:52:17 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)) 10:52:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:52: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 10:52: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 10:52: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 10:52: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 10:52: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 10:52: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 10:52:20 INFO - Downloading blessings-1.6.tar.gz 10:52:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:52:20 INFO - Installing collected packages: blessings 10:52:20 INFO - Running setup.py install for blessings 10:52:20 INFO - Successfully installed blessings 10:52:20 INFO - Cleaning up... 10:52:20 INFO - Return code: 0 10:52:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:52:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:52:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:52:20 INFO - Reading from file tmpfile_stdout 10:52:20 INFO - Current package versions: 10:52:20 INFO - blessings == 1.6 10:52:20 INFO - blobuploader == 1.2.4 10:52:20 INFO - docopt == 0.6.1 10:52:20 INFO - manifestparser == 1.1 10:52:20 INFO - mozInstall == 1.12 10:52:20 INFO - mozcrash == 0.17 10:52:20 INFO - mozdebug == 0.1 10:52:20 INFO - mozdevice == 0.48 10:52:20 INFO - mozfile == 1.2 10:52:20 INFO - mozhttpd == 0.7 10:52:20 INFO - mozinfo == 0.9 10:52:20 INFO - mozleak == 0.1 10:52:20 INFO - mozlog == 3.1 10:52:20 INFO - moznetwork == 0.27 10:52:20 INFO - mozprocess == 0.22 10:52:20 INFO - mozprofile == 0.28 10:52:20 INFO - mozrunner == 6.11 10:52:20 INFO - mozscreenshot == 0.1 10:52:20 INFO - mozsystemmonitor == 0.0 10:52:20 INFO - moztest == 0.7 10:52:20 INFO - mozversion == 1.4 10:52:20 INFO - psutil == 3.1.1 10:52:20 INFO - requests == 1.2.3 10:52:20 INFO - wsgiref == 0.1.2 10:52:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:20 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')]} 10:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:20 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')]} 10:52:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:20 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 0x10da8ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da924c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab40585700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d92fd30>, '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 0x10d753db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d926b20>, '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.7jdLhr7WUO/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.M9h9F3iPKe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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 10:52:20 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 10:52:20 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 10:52:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7jdLhr7WUO/Render', 10:52:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:20 INFO - 'HOME': '/Users/cltbld', 10:52:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:20 INFO - 'LOGNAME': 'cltbld', 10:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:20 INFO - 'MOZ_NO_REMOTE': '1', 10:52:20 INFO - 'NO_EM_RESTART': '1', 10:52:20 INFO - 'PAGER': '/bin/cat', 10:52:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:20 INFO - 'PWD': '/builds/slave/test', 10:52:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:20 INFO - 'SHELL': '/bin/bash', 10:52:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M9h9F3iPKe/Listeners', 10:52:20 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 10:52:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:20 INFO - 'USER': 'cltbld', 10:52:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:20 INFO - 'XPC_FLAGS': '0x0', 10:52:20 INFO - 'XPC_SERVICE_NAME': '0', 10:52:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:20 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)) 10:52:20 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)) 10:52:20 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)) 10:52:20 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)) 10:52:20 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)) 10:52:20 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)) 10:52:20 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)) 10:52:20 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)) 10:52:20 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)) 10:52:20 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)) 10:52:20 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)) 10:52:20 INFO - Cleaning up... 10:52:21 INFO - Return code: 0 10:52:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:52:21 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')]} 10:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:21 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')]} 10:52:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:21 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 0x10da8ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da924c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab40585700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d92fd30>, '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 0x10d753db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d926b20>, '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.7jdLhr7WUO/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.M9h9F3iPKe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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 10:52:21 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 10:52:21 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 10:52:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7jdLhr7WUO/Render', 10:52:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:21 INFO - 'HOME': '/Users/cltbld', 10:52:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:21 INFO - 'LOGNAME': 'cltbld', 10:52:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:21 INFO - 'MOZ_NO_REMOTE': '1', 10:52:21 INFO - 'NO_EM_RESTART': '1', 10:52:21 INFO - 'PAGER': '/bin/cat', 10:52:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:21 INFO - 'PWD': '/builds/slave/test', 10:52:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:21 INFO - 'SHELL': '/bin/bash', 10:52:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M9h9F3iPKe/Listeners', 10:52:21 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 10:52:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:21 INFO - 'USER': 'cltbld', 10:52:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:21 INFO - 'XPC_FLAGS': '0x0', 10:52:21 INFO - 'XPC_SERVICE_NAME': '0', 10:52:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:21 INFO - Downloading/unpacking jsonschema 10:52:21 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 10:52:21 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 10:52:21 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 10:52:21 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 10:52:21 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 10:52:21 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 10:52:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:52:23 INFO - Downloading/unpacking functools32 (from jsonschema) 10:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:24 INFO - Downloading functools32-3.2.3-2.tar.gz 10:52:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:52:24 INFO - warning: no files found matching '*.txt' 10:52:24 INFO - no previously-included directories found matching 'build' 10:52:24 INFO - no previously-included directories found matching 'dist' 10:52:24 INFO - no previously-included directories found matching '.git*' 10:52:24 INFO - Installing collected packages: jsonschema, functools32 10:52:24 INFO - Running setup.py install for functools32 10:52:24 INFO - warning: no files found matching '*.txt' 10:52:24 INFO - no previously-included directories found matching 'build' 10:52:24 INFO - no previously-included directories found matching 'dist' 10:52:24 INFO - no previously-included directories found matching '.git*' 10:52:24 INFO - Successfully installed jsonschema functools32 10:52:24 INFO - Cleaning up... 10:52:24 INFO - Return code: 0 10:52:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da8ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da924c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab40585700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d92fd30>, '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 0x10d753db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d926b20>, '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.7jdLhr7WUO/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.M9h9F3iPKe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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 10:52:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:52:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:52:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7jdLhr7WUO/Render', 10:52:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:52:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:52:24 INFO - 'HOME': '/Users/cltbld', 10:52:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:52:24 INFO - 'LOGNAME': 'cltbld', 10:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:24 INFO - 'MOZ_NO_REMOTE': '1', 10:52:24 INFO - 'NO_EM_RESTART': '1', 10:52:24 INFO - 'PAGER': '/bin/cat', 10:52:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:24 INFO - 'PWD': '/builds/slave/test', 10:52:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:52:24 INFO - 'SHELL': '/bin/bash', 10:52:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M9h9F3iPKe/Listeners', 10:52:24 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 10:52:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:52:24 INFO - 'USER': 'cltbld', 10:52:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:52:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:24 INFO - 'XPC_FLAGS': '0x0', 10:52:24 INFO - 'XPC_SERVICE_NAME': '0', 10:52:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:52:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:24 INFO - Downloading/unpacking flake8 10:52:24 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 10:52:24 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 10:52:24 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 10:52:24 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 10:52:24 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 10:52:24 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 10:52:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:52:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:52:27 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 10:52:27 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 10:52:27 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 10:52:27 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 10:52:27 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 10:52:27 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 10:52:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:52:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:52:27 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 10:52:27 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 10:52:27 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 10:52:27 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 10:52:27 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 10:52:27 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 10:52:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:52:27 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 10:52:27 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 10:52:27 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 10:52:27 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 10:52:27 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 10:52:27 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 10:52:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:52:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:52:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:52:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:52:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:52:28 INFO - no previously-included directories found matching 'docs/_build' 10:52:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:52:28 INFO - Running setup.py install for pep8 10:52:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:52:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:52:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:52:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:52:28 INFO - no previously-included directories found matching 'docs/_build' 10:52:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:52:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:52:28 INFO - Cleaning up... 10:52:28 INFO - Return code: 0 10:52:28 INFO - Running post-action listener: _resource_record_post_action 10:52:28 INFO - Running post-action listener: _start_resource_monitoring 10:52:28 INFO - Starting resource monitoring. 10:52:28 INFO - ##### 10:52:28 INFO - ##### Running install step. 10:52:28 INFO - ##### 10:52:28 INFO - Running pre-action listener: _resource_record_pre_action 10:52:28 INFO - Running main action method: install 10:52:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:52:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:52:28 INFO - Reading from file tmpfile_stdout 10:52:28 INFO - Detecting whether we're running mozinstall >=1.0... 10:52:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:52:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:52:28 INFO - Reading from file tmpfile_stdout 10:52:28 INFO - Output received: 10:52:28 INFO - Usage: mozinstall [options] installer 10:52:28 INFO - Options: 10:52:28 INFO - -h, --help show this help message and exit 10:52:28 INFO - -d DEST, --destination=DEST 10:52:28 INFO - Directory to install application into. [default: 10:52:28 INFO - "/builds/slave/test"] 10:52:28 INFO - --app=APP Application being installed. [default: firefox] 10:52:28 INFO - mkdir: /builds/slave/test/build/application 10:52:28 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'] 10:52:28 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 10:53:02 INFO - Reading from file tmpfile_stdout 10:53:02 INFO - Output received: 10:53:02 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:53:02 INFO - Running post-action listener: _resource_record_post_action 10:53:02 INFO - ##### 10:53:02 INFO - ##### Running run-tests step. 10:53:02 INFO - ##### 10:53:02 INFO - Running pre-action listener: _resource_record_pre_action 10:53:02 INFO - Running main action method: run_tests 10:53:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:53:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:53:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:53:02 INFO - 2016-03-12 10:53:02.937 screenresolution[1651:7787] starting screenresolution argv=screenresolution get 10:53:02 INFO - 2016-03-12 10:53:02.940 screenresolution[1651:7787] Display 0: 1600x1200x32@60 10:53:02 INFO - 2016-03-12 10:53:02.946 screenresolution[1652:7789] starting screenresolution argv=screenresolution list 10:53:02 INFO - Available Modes on Display 0 10:53:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:53:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:53:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:53:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:53:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:53:03 INFO - Intel Iris: 10:53:03 INFO - Chipset Model: Intel Iris 10:53:03 INFO - Type: GPU 10:53:03 INFO - Bus: Built-In 10:53:03 INFO - VRAM (Dynamic, Max): 1536 MB 10:53:03 INFO - Vendor: Intel (0x8086) 10:53:03 INFO - Device ID: 0x0a2e 10:53:03 INFO - Revision ID: 0x0009 10:53:03 INFO - Displays: 10:53:03 INFO - Display: 10:53:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:53:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:53:03 INFO - Display Serial Number: 1600x1200 60 10:53:03 INFO - Main Display: Yes 10:53:03 INFO - Mirror: Off 10:53:03 INFO - Online: Yes 10:53:03 INFO - Rotation: Supported 10:53:03 INFO - Return code: 0 10:53:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:53:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:53:03 INFO - Python 2.7.3 10:53:03 INFO - Return code: 0 10:53:03 INFO - grabbing minidump binary from tooltool 10:53:03 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')]} 10:53:03 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 0x10d92fd30>, '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 0x10d753db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d926b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:53:03 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 10:53:03 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 10:53:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:53:03 INFO - Return code: 0 10:53:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:53:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:53:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:53:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:53:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:53:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:53:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:53:04 INFO - Return code: 0 10:53:04 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G1WF6RILS7-vygX84T-eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0060', '--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 10:53:04 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G1WF6RILS7-vygX84T-eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0060 --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 10:53:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7jdLhr7WUO/Render', 10:53:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:04 INFO - 'HOME': '/Users/cltbld', 10:53:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:04 INFO - 'LOGNAME': 'cltbld', 10:53:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:53:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:04 INFO - 'MOZ_NO_REMOTE': '1', 10:53:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:53:04 INFO - 'NO_EM_RESTART': '1', 10:53:04 INFO - 'PAGER': '/bin/cat', 10:53:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:04 INFO - 'PWD': '/builds/slave/test', 10:53:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:53:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:04 INFO - 'SHELL': '/bin/bash', 10:53:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.M9h9F3iPKe/Listeners', 10:53:04 INFO - 'TMPDIR': '/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/', 10:53:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:04 INFO - 'USER': 'cltbld', 10:53:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:04 INFO - 'XPC_FLAGS': '0x0', 10:53:04 INFO - 'XPC_SERVICE_NAME': '0', 10:53:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:04 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G1WF6RILS7-vygX84T-eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0060', '--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 10:53:04 INFO - mozversion application_buildid: 20160312100030 10:53:04 INFO - mozversion application_changeset: b8efc6dc729ea6b1b5de4e6aca866ee52d7dccf9 10:53:04 INFO - mozversion application_display_name: Nightly 10:53:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:53:04 INFO - mozversion application_name: Firefox 10:53:04 INFO - mozversion application_remotingname: firefox 10:53:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:53:04 INFO - mozversion application_vendor: Mozilla 10:53:04 INFO - mozversion application_version: 48.0a1 10:53:04 INFO - mozversion platform_buildid: 20160312100030 10:53:04 INFO - mozversion platform_changeset: b8efc6dc729ea6b1b5de4e6aca866ee52d7dccf9 10:53:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:53:04 INFO - mozversion platform_version: 48.0a1 10:53:04 INFO - using testdate: 1457808784 10:53:04 INFO - actual date: 1457808784 10:53:04 INFO - starting webserver on 'localhost:49271' 10:53:04 INFO - SUITE-START | Running 2 tests 10:53:04 INFO - TEST-START | dromaeo_css 10:53:04 INFO - operating with platform_type : mac_ 10:53:04 INFO - Initialising browser for dromaeo_css test... 10:53:04 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/tmpt7ZrVn/profile http://localhost:49271/getInfo.html) 10:53:07 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 10:53:07 INFO - PROCESS | 1670 | colorDepth:24 10:53:07 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 10:53:07 INFO - PROCESS | 1670 | __metrics 10:53:07 ERROR - PROCESS | 1670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 10:53:08 INFO - TEST-INFO | 1670: exit 0 10:53:08 INFO - Browser initialized. 10:53:08 INFO - Running cycle 1/1 for dromaeo_css test... 10:53:08 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/tmpt7ZrVn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:53:20 INFO - PROCESS | 1674 | RSS: Main: 255512576 10:53:20 INFO - PROCESS | 1674 | 10:54:10 INFO - PROCESS | 1674 | 1457808850069 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] 10:56:21 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 10:56:22 INFO - PROCESS | 1674 | RSS: Main: 268406784 10:56:22 INFO - PROCESS | 1674 | 10:59:24 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 10:59:25 INFO - PROCESS | 1674 | RSS: Main: 281251840 10:59:25 INFO - PROCESS | 1674 | 11:02:26 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 11:02:27 INFO - PROCESS | 1674 | RSS: Main: 281145344 11:02:27 INFO - PROCESS | 1674 | 11:05:29 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 11:05:29 INFO - PROCESS | 1674 | RSS: Main: 284352512 11:05:29 INFO - PROCESS | 1674 | 11:08:32 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 11:08:33 INFO - PROCESS | 1674 | RSS: Main: 285569024 11:08:33 INFO - PROCESS | 1674 | 11:11:35 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 11:11:35 INFO - PROCESS | 1674 | RSS: Main: 288022528 11:11:35 INFO - PROCESS | 1674 | 11:11:35 INFO - PROCESS | 1674 | __start_tp_report 11:11:35 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 11:11:35 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 11:11:35 INFO - PROCESS | 1674 | |i|pagename|runs| 11:11:35 INFO - PROCESS | 1674 | |0;dojo.html;3497.090756403335;3500.6674365935237;3540.6990405815504;3551.2897420515887;3587.0852932502207;5015.147424937761;5751.798687045949;5770.538356931446;5796.362400135992;5809.070548712201;5636.718164091789;5731.111677689954;5750;5796.5652576056755;5891.440313170253;4579.954200457986;5171.405288391836;5206.739663016853;5222.921656175142;5227.5295223429885;4402.933955990663;5240.947590524103;5280.762365693534;5300.973495132519;5304.230886521452;5124.743762811844;5151.304573882534;5203.063448579254;5208.791648334062;5264.499872512143;5160.587153027749;5189.7405129743365;5217.217417387385;5229.2417599448245;5245.606579506552;5133.178691409394;5183.61122915779;5192.3249977503065;5192.688438693691;5215.400228973679;3932.429797679349;5654.802081927113;5728.398518155617;5747.453991870808;5793.304803423574;6255.749770009194;6322.430981211713;6324.367563243685;6331.303556608769;6354.650494222816;6114.7840275394365;6276.184096067527;6282.465990390822;6330.430261276507;6344.238691357021;5942.732577034044;5986.9401305986385;5994.820155395345;5999;6038.0942858571125;5622.297212848394;6333.683315834282;6354.777582784673;6392.808215753535;6399.296077431479;4847.80608775652;6079.361667024988;6132.110843927606;6271.123352936852;6305.369463053658;5119.795208191631;6187.16473276111;6313.589616674902;6341.873162536724;6368.936310636927;5205.609579281569;6213.130161777355;6276.6547839869245;6312.495000399957;6326.335734747877;5194;6114.571104522756;6140.688304616564;6262.248530176408;6293.5082358201735;4960.355153829979;4990.326305948651;4996.750162491933;5003.574696150868;5053.292539044537;4504.391907092566;4508.45898492183;4512.120136573402;4526.751028693454;4530.61489773373;5748.223989761329;5876.1479585459865;5986.610870293417;5998.4601385875485;6011.819645410645;6301.4328710416285;6304.968475157595;6318.684065796691;6320.5259605528845;6371.044343348535;5882.294124705063;5904.76380944766;5913.46778789911;5913.497352725067;5916.1767192925345;5350.919736203882;5369.4362091980565;5429.972850135724;5456.699881506555;5504;6431.549791514549;6445.742170313229;6477.4494167996245;6490.221173459215;6490.383413575702;6323.051542268512;6325.304216536269;6334.809955701337;6352.078948552342;6352.682365881595;6194.938050619436;6395;6441.645709486023;6504.4796416285635;6507.28419873823;6257.405546473078;6309.274433440213;6320.778772742932;6323.988161894074;6342.524310676626;6198.907016394667;6337.683115844282;6340.71466784005;6341.55609107358;6351.301356850835;6086.178365920544;6118.497354392036;6130.153553065376;6227.595206311576;6263.655498947602;6265.27949285838;6266.592671476339;6274.152989346379;6279.309275979547;6285.96857015712;4500.347449619721;5405.594580406564;6056.545759068;6082.057281121433;6129;6049.606775559574;6134.191681014119;6185;6215.850067737483;6261.092141639346;6097.298810636834;6132;6143.84640383994;6148.415900489446;6153.84615384619 11:11:35 INFO - PROCESS | 1674 | |1;ext.html;455.2965668042875;495.44262704457486;523.8637954131927;599.970001499925;602.632394239514;30838.53742193866;38613.613863861356;38687.226255474874;38720;38799.41800872989;32241.35517289653;39205;39711.0072248194;39720;39746.60253397465;8341.874871876928;9460.57427415768;9612.615495380176;9651.372660777062;9768.804623907517;8694.869576956351;9771;9773.169280611157;9827.361221520578;9854.359466634645;9677.612895484208;9723.902760972405;9836.262280328969;9857.753556161082;9882.357646752975;9739.902600974006;9745.512724363789;9854.852177217348;9855.408675479493;9873.506324683736;9573.617055317849;9700.223982081416;9708.368956017835;9708.514574271328;9720.90279097207;38723.225535489415;38816.61183388186;38874.61125388766;39016;39130.60869391298;3244.0430073128246;3290.8683652653867;3536.2750636119536;3850.614938506127;3922.960770392288;28283.434331313463;29440.263993400335;29677.258068548243;29948.550771738443;30452.8477357614;2442.560339138954;2755.875985580654;2757.310672331917;2770.667519897605;2913.7086291370906;492308;498109.50945245405;499189;500104.49947750027;500480;45720.54279457163;64673.35326646674;65027;65222;65350.673246633465;46849.5315046852;47116.76441617838;47662.523374766504;47673;47811.76094119507;16341.101239431708;16462.42381516641;16525;16549.338026478807;16572.005679659258;13122.671933201746;13183.934080329536;13270;13272.535461258809;13276.004299677563;14815.703685926437;14911.776323355158;15021.324040418207;15073.849261507465;15162.545123646309;6544.214694236627;6736.8989465158065;6764.120664313607;6767.086443330186;6771.28901465339;881.8589025755977;966.7438128895848;982.6069572171189;1046.2310202001522;1050.8719842319213;27886;29331.85334073316;29766.809327627085;29798.95703650362;29871.253218669706;939.6570251858022;1099.1591432554103;1117.7038084907506;1190.7261329894172;1207.456644509974;11965.581204657796;14477.493287734878;15148.772768408482;15285.082895026335;15399.846001539841;608795;620721;634883;638256;639201;54482.727586362606;55723.885522289325;56368.43631563714;60737;61964.69017654973;1496.7904493370936;1525.3364786317986;1536.6849795791836;1538.3846461415524;1548.6670365871391;29927.251818704706;30671.079867604007;30816.229594260323;31244.843775780977;31650.841745792044;54131.72934135304;54246.45753542572;54422.72788636031;54637.1804422926;54712;483728;488716;492677;496741;497575;46304.768476157406;47337.52662473469;48064.75967620139;48489;49544.50455495399;43258.35112473378;45497.545024549334;46009.929553170856;46024.769876151746;46438.071238575714;37171.44242836306;37975.810120949216;37978.240435190586;38110.42834357431;38758.22483550369;37445.6255437453;37507.43738843974;37553;38020.42969355406;38205.80897095497;36622.63377366299;36797.08007299839;37186.25627487489;37762.43356349602;37779.81110094432;32665.673343266262;32973;33029.834850825595;33481.66518334785;33542.49686254757;24061.157859474835;24867.50264994654;25052.62421063649;25235.11677091293;25401.745982540677 11:11:35 INFO - PROCESS | 1674 | |2;jquery.html;361.26302343219817;366.1541838353404;372.0883834605217;374.3916136278547;375.1933343311879;16098.35606575737;19353.322633707823;19734.21063157472;19895.60208795827;19958.301459448903;17465.214065367058;19822.702659460083;20029.499262518446;20711.482212944684;20734.585308293863;5659.462351076641;5944.673042982634;5980.192673989;5992.34084250732;5992.970035149818;4199.727017743837;5891.145783861338;6203.596766210205;6471.061696054069;6477.708503117371;6415.1339569158035;6417.358264173592;6417.39034791694;6448;6510.121133646944;5494.09347457669;5674.375818659964;5714.085746280617;5771.307443106812;5791.681457519835;5280.656757310762;5442.564594832444;5522.420145884665;5527.474889885454;5542.974549708277;23260.883695581415;23642.881785590962;23670;23737.525249495087;24323;2121.459027947879;2218.3566765637947;2254.447660323215;2275.67002784597;2682.208748419221;8833.33749968755;9662.13040826322;10012.998700130001;10027.147692446151;10073.244506661957;1341.3896677011935;1594.234767311697;1704.1564425609279;1732.601501654614;1733.5752740578512;106521.46739266331;106660.99999999923;108356.4582177092;108948;109519;10965.780684386267;11187.888121118685;11384.20310578268;11402.543898243977;11526.538938442536;13599.048066635438;13720.93139534316;13729;13761.587152385444;13793.931030344784;7960;8463.661453541912;8492.575371231414;8610.268127209258;8764.430312029697;7281.490295679251;8001.959990200012;8767.21095101444;8867;8902.332325075646;4397.450318710161;4404.691671583022;4460.420145381079;4476.597106260387;4493.033997690447;1674.6232097778145;1777.4667599720033;1834.3322024440986;1867.1037901806937;1921.5868588253593;784.8704963681043;863.9654413823376;963.2438535749403;984.8178087053918;1006.114619135171;14630.634234144232;20351.898240508704;20363.4909127273;20494.487637809176;20649.96750162516;948.1466679987929;963.8120566489467;975.9707208783748;986.1765425869336;1030.3302853145365;9807.607695692235;11013.504392302366;11030.50362733679;11037;11047.613333533287;213082;213760;214826.62933426476;215185;216232.8376716244;115729;117220;117403;118284;121440.78559214472;1008.0574662690408;1009.6264382178641;1016.0550687860214;1028.573142146001;1029.7322696099068;18126.27494900189;18271.908640456713;18327.266909323476;18407.355742548945;18446.800957938227;48975.75512122417;49487.01025979532;49872;50145;51337;74430.31398915143;74721.6263918677;75532;75729.86405204037;77790;7819;7847.646855891385;7921.366290696846;7991.600419979094;8013.959930200312;11512.481938312963;12348;12433.502659893864;12638.494460221487;12651.87348126507;9925.751856203364;10299.794004120025;10462.843057354297;10739.838902416313;10819.621313253998;9777.315587908779;10407.167426606005;10572.735681608021;10707.464626768786;10930.836037459285;9422.916364617882;9793.118619324296;10677.412742299248;10876.619318324138;11107.611233607107;7728.652210650422;7784.494007889695;7963.402744794048;7985.680572777256;11093.50079246452;10887;10972.396518191257;11014.504347304552;11109.555617775522;11157.884211578777 11:11:35 INFO - PROCESS | 1674 | |3;mootools.html;1479.1494890437998;1613.56433762884;1905.1902941249973;2003.889786061767;2012.9396118116442;7590.392768578514;7983.9201607983905;8712.56437178141;8922;8951.328650351217;7387.8153046173875;8561.657533698644;8669.86995195071;8776.868346974801;8793.824123517526;2448.9877550612223;2465.506898620274;2468.308873515419;2468.4939587384633;2469;2426.0538390027905;2459.7909177719916;2478.355627536844;2483.8758062096913;2487.800975921931;2045.1512622261744;2408.6989126359204;2439.1097249503982;2439.841410308324;2444;2463.1748364297982;2468.0127948820436;2468.580341341967;2487.117073438921;2488.4525404411092;2414.9615665263927;2476.9752302476923;2483.428811373394;2490.2778194323623;2493.4265119022543;8890.288776897833;8892.3330750194;8936.32977526688;8955.059718729504;8988.32587555936;5408.972955135238;5528.226048353234;5548.44515548446;5555.611107222496;5557.3886872444;3558.3061303045915;3656.6160553142067;3670.394384926484;3706.9073273168115;3749.850005999757;1048.2505008918583;1067.8665166854144;1072.2601405030505;1072.745225489848;1080.2924084724518;11928.821067683904;12045.457954392074;12072.818907716304;12084.033277337792;12088.818667719992;4904.068227036852;4935.383077115361;4943.209086546135;4968.254761785689;4973.42805577356;10226.28416010872;10226.6420675276;10229.130523905551;10240.539175737109;10270;5475.589330800206;5511.53151982086;5525.4474552544425;5541.974734674018;5560.805371811967;4411.029573493826;4873.610111191097;4988.675736077216;5002.799888004512;5020.171671674133;3921.352976758803;3966.900827479336;3971.8808435746973;4003.4395184674167;4027.496562929634;1344.8520662727092;1368.726254749054;1369.1442848219863;1380.7928810678277;1380.9861901380857;1355.5255660518937;1382.7994940733538;1384.1141669331637;1399.7690381087211;1415.0943396226423;8206.425550211428;8272.545010024385;8296.294814940677;8308.958455207685;8344.707935222237;502.53013432440787;508.0372693745332;515.28632843512;517.3998162131909;518.8599078248851;6076.605020673642;6143.170671959318;6193.071039344044;6195.349488303754;6197.96901015492;10223.488825558692;10426.322289051188;10426.843597346045;10471.16230701542;10534.420606866695;10199.592016319413;10276.948615256875;10316.226283028653;10335.328203666888;10379.429131397694;7601.315881570686;7691.46159768822;8001.359891208689;8277.58612069394;8282.8343433131;7997.960010199912;8094.231048050426;8136;8149.348052155695;8168.550729709923;9274.768130796783;9428.292878034312;9482.95258523703;9558.665446709332;9735.367201131903;9595.568199430903;9784.168345690412;9800.411975281506;9879.012098790063;9990.750231244278;6734.6632668367365;7116.50184487081;7393.9260607393235;7542.208068152765;7716.498427602188;8178.754637360888;8203.425760196968;8249.422540422112;8253.628586713492;8301.792455188668;7194.928050719426;7242.529235599669;7256;7259.673314700745;7466.440016998638;7111.644417779194;7138.39323657495;7230.602316872622;7288.96355518219;7332.743353982585;5869.941300586939;7739.34215591681;7825.960870195612;7875.566843823644;7989.360851131779;6999.790006299819;7025.508214424941;7058.059033765756;7088.432925365855;7092.219855815753;7068.71725130989;7107.18267399235;7155.284471553011;7165.605891676008;7175.964120179366 11:11:35 INFO - PROCESS | 1674 | |4;prototype.html;326.10321615557217;332.27066588837494;334.54501877446654;337.84625503904164;339.6382852262339;5589.496945274925;6915.827104322394;6932.965335173323;6996.8950465743055;7044.436445084394;6839.076724642172;6869.519133660633;6939.028536004963;6949.339812717783;6967.79096627102;4150.626443620066;4839.830605928793;4928.901421971558;5041.546260836524;5042.722650254234;5019.824306149286;5025;5053;5057.03916255912;5062.848114556569;4503.234450143484;4511.887202819923;4985.925211121836;4987.451380348159;4987.725675087869;4993.550580447759;5012.949870501303;5034.270030845507;5039.344885164942;5043.5965122790085;4328.783560821947;4332.653387728974;4343.500497442803;4347.043650396908;4360.454943132108;6394.392532709432;6654.2014958204845;6700.262971073178;6711.731530738764;6749.6962636681465;4452.821887124511;5888.322842873082;5916.083007133901;5933.021051526493;5935.2877654681715;5971.790987315467;7318.524295920748;7367.557946523226;7372.373348265404;7376.815579610499;4709.7174169549935;4710.3405523226775;4711.081339138869;4723.740194289313;4739.218029025206;7304.5982470963545;7693.615319234016;7746.18665040174;7751.22487751226;7779.649915753805;3920.941185882214;4572.451305843254;4644.349791029259;4738;4745.501722319176;4821.300911367832;4827.203511420576;4827.589654879374;4828.082664293773;4846.491118432585;4832.936753914133;5741.85645358861;5783.045797443375;5785.971070144622;5788.18965344852;6753.425958793558;6765.323467653294;7305.525140865827;7359;7387.8153046174275;1665.700173968673;1688.9831101689072;1692.7884014498188;1695.5930576661513;1698.2527687817567;1043.9321444106108;1067.492940853104;1078.5092782783815;1080;1083.3391631105019;6215.844603884849;6784.287649796799;6819.897701534481;6822.4200942919415;6864.313568643096;7595.734149304748;7606.603919765256;7614.8096297593;7630.923690763132;7637.312641862259;6075.210222671113;6807.455403567703;6825.317468253135;6831.419329356961;6831.9658401707675;3763.6236376362695;4052.2098190852503;4053.250148722496;4053.574374690674;4058.066644671742;7740.651670674721;8029.518228906168;8036.799080022929;8059.717909873127;8064.354851611857;7885.6594378955715;7914.327282181079;7922.762317130495;7940.16628254025;7984.520928744178;7987.3610111190965;8004.279079997828;8005.559694216874;8017.759467215993;8023.638936247883;7446.962765186356;7643.503172293783;7713.498622589514;7715;7727.188645192174;7516.5114267572435;7528.435367347581;7553.660085296065;7565.167831538416;7584.5070070445245;7930.9603451982375;7955.1249362568915;7970.8007299815645;7998.160193179632;7999.800004999922;3988.501437320335;4747.240441529477;4792.832250871203;4804.342501836861;4870.829520966749;7360.33756961876;7602;7702.537847729154;7725.304722574995;7739.264769846855;7381.11426628808;7416.184219735716;7421.332080112816;7427.702891884264;7430.294122058396;7403.555786652818;7409.259074092548;7432.219616940143;7438.293362130589;7454.030975973089;7003.509754317352;7214.927850721426;7247.347738703542;7249.818754531179;7269.619626873529;7372.741954031583;7413.1104267488245;7423.331900129015;7428.9628551856895;7441.8139546511775;7213.639318033972;7220.963895180491;7229.385502232369;7242;7243.529170603894 11:11:35 INFO - PROCESS | 1674 | |5;yui.html;706.8904319830426;725;732.7508647059999;759;765.1430397954289;14587.34356953937;14734.852651473482;14830;14833.629159271024;14901.403943842246;15740;16038.518844434686;16050.83949160508;16053.759193612075;16086.83913160868;782.9725959591416;953.2374100719431;965.2760429677742;974.5224839828469;974.6442548469828;902.620899222325;952.5237381309346;964.0504103458123;964.6479035152154;966.014665041657;956.6795123633591;995.6913356859396;1014.8629934958797;1016.9847452288221;1019.7603563162651;976.4824642939253;998.8451789972494;999.2355847776457;1001.9098281154731;1009.7677534167109;743.0674503498076;748.2181120728851;751.4739682222412;753.1075675324703;755.8790593505067;15170.696586068218;15251.161186134868;15264.618384540365;15456.381744730197;15536.300866461037;12973.740525189538;13001;13002.934985325108;13125.737485250242;13215.20708757468;10019.949900250525;10076.798464030751;10107.39355638664;10177.134943529809;10346.37921724699;3522.0314413536485;3547.627499112582;3558.5729712434413;3663.816809159531;3706.684931780802;76615.85076223861;76888.23111768923;77285.45429091387;77770;77984.61007694982;7924.920750792534;9340.532973351304;9486.478243696663;9555.426674399558;9561.808763824685;21251.46871328229;21550.245741398976;21604.891975540337;21611.02750376237;22023.22918697838;7351.22812104732;7454.552726836408;7473.813154671177;7475.0656167979005;7756.728514502078;4023.6982226333143;4069.450624165759;4075.918481630351;4079.0618157823865;4080.693947953856;3622.1306886347616;3638.7816730996224;3686.225892562592;3690.040589446763;3699.352613292663;640.9583377080475;641.0416427441005;651.364919203782;651.5113664751436;654.3652656922777;512.5003121956138;556.2712846171528;577.708257330054;608.5679167790829;612.4295358062485;7160.928390716131;7568.508046976929;8064.314533264738;8285.25432711059;8650.826983460296;523.5445162708468;571.6170165988798;571.8198767388259;623.1120653069358;635.4820821030937;3758.699304055669;3775.4525593789294;3805.6765174959883;3865.9613403866165;3873.438351439082;62931.685341573;83640;84967.7254841178;85038.14961850426;94214;70068.6496567514;75223;76715;77155.2284477148;78927.60536197282;68784.31215687779;68891.96662050074;68938.65530672415;70045;71051;6566.606003639797;7562.774311050009;7637.541747495168;7777.4166937478785;7911.762647120596;48188.79528011828;48266;48564.2715359277;49212.75393623152;49983.25025124699;49988.50011499839;63929.68035159794;63966;64255.03617445649;67064.66467667825;10056.446895420822;10179.592816287266;10855.185861060294;11072.446377681244;11542.365169915734;11850.822237666614;12046.819297710717;12047.578334758242;12105.031597472358;12256.571020014257;11052.0385014419;11133.317424332803;11409.60066397672;11459.427028648368;11522.942385288019;11107.222494425636;11173.05029072538;11413.885861141614;11489.827652585385;11505.884941150482;11020.559177632806;11022.669319920415;11029.404477567577;11382.373969431761;11404.144689148181;9217.76955576116;9252.53737313145;9320.161185493338;9516.666916657883;9671.70984870455;8913.777155571162;9495.525223738923;9516.552366437812;9558.091981261769;9623.807523849624 11:11:35 INFO - PROCESS | 1674 | __end_tp_report 11:11:35 INFO - PROCESS | 1674 | __start_cc_report 11:11:35 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,371 11:11:35 INFO - PROCESS | 1674 | __end_cc_report 11:11:35 INFO - PROCESS | 1674 | __startTimestamp1457809895784__endTimestamp 11:11:35 INFO - PROCESS | 1674 | 11:11:35 INFO - PROCESS | 1674 | ------- Summary: start ------- 11:11:35 INFO - PROCESS | 1674 | Number of tests: 6 11:11:35 INFO - PROCESS | 1674 | 11:11:35 INFO - PROCESS | 1674 | [#0] dojo.html Cycles:165 Average:5764.78 Median:6049.61 stddev:687.97 (11.4%) stddev-sans-first:666.69 11:11:35 INFO - PROCESS | 1674 | Values: 3497.1 3500.7 3540.7 3551.3 3587.1 5015.1 5751.8 5770.5 5796.4 5809.1 5636.7 5731.1 5750.0 5796.6 5891.4 4580.0 5171.4 5206.7 5222.9 5227.5 4402.9 5240.9 5280.8 5301.0 5304.2 5124.7 5151.3 5203.1 5208.8 5264.5 5160.6 5189.7 5217.2 5229.2 5245.6 5133.2 5183.6 5192.3 5192.7 5215.4 3932.4 5654.8 5728.4 5747.5 5793.3 6255.7 6322.4 6324.4 6331.3 6354.7 6114.8 6276.2 6282.5 6330.4 6344.2 5942.7 5986.9 5994.8 5999.0 6038.1 5622.3 6333.7 6354.8 6392.8 6399.3 4847.8 6079.4 6132.1 6271.1 6305.4 5119.8 6187.2 6313.6 6341.9 6368.9 5205.6 6213.1 6276.7 6312.5 6326.3 5194.0 6114.6 6140.7 6262.2 6293.5 4960.4 4990.3 4996.8 5003.6 5053.3 4504.4 4508.5 4512.1 4526.8 4530.6 5748.2 5876.1 5986.6 5998.5 6011.8 6301.4 6305.0 6318.7 6320.5 6371.0 5882.3 5904.8 5913.5 5913.5 5916.2 5350.9 5369.4 5430.0 5456.7 5504.0 6431.5 6445.7 6477.4 6490.2 6490.4 6323.1 6325.3 6334.8 6352.1 6352.7 6194.9 6395.0 6441.6 6504.5 6507.3 6257.4 6309.3 6320.8 6324.0 6342.5 6198.9 6337.7 6340.7 6341.6 6351.3 6086.2 6118.5 6130.2 6227.6 6263.7 6265.3 6266.6 6274.2 6279.3 6286.0 4500.3 5405.6 6056.5 6082.1 6129.0 6049.6 6134.2 6185.0 6215.9 6261.1 6097.3 6132.0 6143.8 6148.4 6153.8 11:11:35 INFO - PROCESS | 1674 | 11:11:35 INFO - PROCESS | 1674 | [#1] ext.html Cycles:180 Average:67559.50 Median:39167.80 stddev:144922.74 (370.0%) stddev-sans-first:145241.71 11:11:35 INFO - PROCESS | 1674 | Values: 455.3 495.4 523.9 600.0 602.6 30838.5 38613.6 38687.2 38720.0 38799.4 32241.4 39205.0 39711.0 39720.0 39746.6 8341.9 9460.6 9612.6 9651.4 9768.8 8694.9 9771.0 9773.2 9827.4 9854.4 9677.6 9723.9 9836.3 9857.8 9882.4 9739.9 9745.5 9854.9 9855.4 9873.5 9573.6 9700.2 9708.4 9708.5 9720.9 38723.2 38816.6 38874.6 39016.0 39130.6 3244.0 3290.9 3536.3 3850.6 3923.0 28283.4 29440.3 29677.3 29948.6 30452.8 2442.6 2755.9 2757.3 2770.7 2913.7 492308.0 498109.5 499189.0 500104.5 500480.0 45720.5 64673.4 65027.0 65222.0 65350.7 46849.5 47116.8 47662.5 47673.0 47811.8 16341.1 16462.4 16525.0 16549.3 16572.0 13122.7 13183.9 13270.0 13272.5 13276.0 14815.7 14911.8 15021.3 15073.8 15162.5 6544.2 6736.9 6764.1 6767.1 6771.3 881.9 966.7 982.6 1046.2 1050.9 27886.0 29331.9 29766.8 29799.0 29871.3 939.7 1099.2 1117.7 1190.7 1207.5 11965.6 14477.5 15148.8 15285.1 15399.8 608795.0 620721.0 634883.0 638256.0 639201.0 54482.7 55723.9 56368.4 60737.0 61964.7 1496.8 1525.3 1536.7 1538.4 1548.7 29927.3 30671.1 30816.2 31244.8 31650.8 54131.7 54246.5 54422.7 54637.2 54712.0 483728.0 488716.0 492677.0 496741.0 497575.0 46304.8 47337.5 48064.8 48489.0 49544.5 43258.4 45497.5 46009.9 46024.8 46438.1 37171.4 37975.8 37978.2 38110.4 38758.2 37445.6 37507.4 37553.0 38020.4 38205.8 36622.6 36797.1 37186.3 37762.4 37779.8 32665.7 32973.0 33029.8 33481.7 33542.5 24061.2 24867.5 25052.6 25235.1 25401.7 11:11:35 INFO - PROCESS | 1674 | 11:11:35 INFO - PROCESS | 1674 | [#2] jquery.html Cycles:180 Average:23405.65 Median:215708.92 stddev:42216.20 (19.6%) stddev-sans-first:42299.17 11:11:35 INFO - PROCESS | 1674 | Values: 361.3 366.2 372.1 374.4 375.2 16098.4 19353.3 19734.2 19895.6 19958.3 17465.2 19822.7 20029.5 20711.5 20734.6 5659.5 5944.7 5980.2 5992.3 5993.0 4199.7 5891.1 6203.6 6471.1 6477.7 6415.1 6417.4 6417.4 6448.0 6510.1 5494.1 5674.4 5714.1 5771.3 5791.7 5280.7 5442.6 5522.4 5527.5 5543.0 23260.9 23642.9 23670.0 23737.5 24323.0 2121.5 2218.4 2254.4 2275.7 2682.2 8833.3 9662.1 10013.0 10027.1 10073.2 1341.4 1594.2 1704.2 1732.6 1733.6 106521.5 106661.0 108356.5 108948.0 109519.0 10965.8 11187.9 11384.2 11402.5 11526.5 13599.0 13720.9 13729.0 13761.6 13793.9 7960.0 8463.7 8492.6 8610.3 8764.4 7281.5 8002.0 8767.2 8867.0 8902.3 4397.5 4404.7 4460.4 4476.6 4493.0 1674.6 1777.5 1834.3 1867.1 1921.6 784.9 864.0 963.2 984.8 1006.1 14630.6 20351.9 20363.5 20494.5 20650.0 948.1 963.8 976.0 986.2 1030.3 9807.6 11013.5 11030.5 11037.0 11047.6 213082.0 213760.0 214826.6 215185.0 216232.8 115729.0 117220.0 117403.0 118284.0 121440.8 1008.1 1009.6 1016.1 1028.6 1029.7 18126.3 18271.9 18327.3 18407.4 18446.8 48975.8 49487.0 49872.0 50145.0 51337.0 74430.3 74721.6 75532.0 75729.9 77790.0 7819.0 7847.6 7921.4 7991.6 8014.0 11512.5 12348.0 12433.5 12638.5 12651.9 9925.8 10299.8 10462.8 10739.8 10819.6 9777.3 10407.2 10572.7 10707.5 10930.8 9422.9 9793.1 10677.4 10876.6 11107.6 7728.7 7784.5 7963.4 7985.7 11093.5 10887.0 10972.4 11014.5 11109.6 11157.9 11:11:35 INFO - PROCESS | 1674 | 11:11:35 INFO - PROCESS | 1674 | [#3] mootools.html Cycles:180 Average:6033.14 Median:5442.28 stddev:3169.17 (58.2%) stddev-sans-first:3159.58 11:11:35 INFO - PROCESS | 1674 | Values: 1479.1 1613.6 1905.2 2003.9 2012.9 7590.4 7983.9 8712.6 8922.0 8951.3 7387.8 8561.7 8669.9 8776.9 8793.8 2449.0 2465.5 2468.3 2468.5 2469.0 2426.1 2459.8 2478.4 2483.9 2487.8 2045.2 2408.7 2439.1 2439.8 2444.0 2463.2 2468.0 2468.6 2487.1 2488.5 2415.0 2477.0 2483.4 2490.3 2493.4 8890.3 8892.3 8936.3 8955.1 8988.3 5409.0 5528.2 5548.4 5555.6 5557.4 3558.3 3656.6 3670.4 3706.9 3749.9 1048.3 1067.9 1072.3 1072.7 1080.3 11928.8 12045.5 12072.8 12084.0 12088.8 4904.1 4935.4 4943.2 4968.3 4973.4 10226.3 10226.6 10229.1 10240.5 10270.0 5475.6 5511.5 5525.4 5542.0 5560.8 4411.0 4873.6 4988.7 5002.8 5020.2 3921.4 3966.9 3971.9 4003.4 4027.5 1344.9 1368.7 1369.1 1380.8 1381.0 1355.5 1382.8 1384.1 1399.8 1415.1 8206.4 8272.5 8296.3 8309.0 8344.7 502.5 508.0 515.3 517.4 518.9 6076.6 6143.2 6193.1 6195.3 6198.0 10223.5 10426.3 10426.8 10471.2 10534.4 10199.6 10276.9 10316.2 10335.3 10379.4 7601.3 7691.5 8001.4 8277.6 8282.8 7998.0 8094.2 8136.0 8149.3 8168.6 9274.8 9428.3 9483.0 9558.7 9735.4 9595.6 9784.2 9800.4 9879.0 9990.8 6734.7 7116.5 7393.9 7542.2 7716.5 8178.8 8203.4 8249.4 8253.6 8301.8 7194.9 7242.5 7256.0 7259.7 7466.4 7111.6 7138.4 7230.6 7289.0 7332.7 5869.9 7739.3 7826.0 7875.6 7989.4 6999.8 7025.5 7058.1 7088.4 7092.2 7068.7 7107.2 7155.3 7165.6 7176.0 11:11:35 INFO - PROCESS | 1674 | 11:11:35 INFO - PROCESS | 1674 | [#4] prototype.html Cycles:180 Average:5986.68 Median:6828.37 stddev:1966.65 (28.8%) stddev-sans-first:1925.73 11:11:35 INFO - PROCESS | 1674 | Values: 326.1 332.3 334.5 337.8 339.6 5589.5 6915.8 6933.0 6996.9 7044.4 6839.1 6869.5 6939.0 6949.3 6967.8 4150.6 4839.8 4928.9 5041.5 5042.7 5019.8 5025.0 5053.0 5057.0 5062.8 4503.2 4511.9 4985.9 4987.5 4987.7 4993.6 5012.9 5034.3 5039.3 5043.6 4328.8 4332.7 4343.5 4347.0 4360.5 6394.4 6654.2 6700.3 6711.7 6749.7 4452.8 5888.3 5916.1 5933.0 5935.3 5971.8 7318.5 7367.6 7372.4 7376.8 4709.7 4710.3 4711.1 4723.7 4739.2 7304.6 7693.6 7746.2 7751.2 7779.6 3920.9 4572.5 4644.3 4738.0 4745.5 4821.3 4827.2 4827.6 4828.1 4846.5 4832.9 5741.9 5783.0 5786.0 5788.2 6753.4 6765.3 7305.5 7359.0 7387.8 1665.7 1689.0 1692.8 1695.6 1698.3 1043.9 1067.5 1078.5 1080.0 1083.3 6215.8 6784.3 6819.9 6822.4 6864.3 7595.7 7606.6 7614.8 7630.9 7637.3 6075.2 6807.5 6825.3 6831.4 6832.0 3763.6 4052.2 4053.3 4053.6 4058.1 7740.7 8029.5 8036.8 8059.7 8064.4 7885.7 7914.3 7922.8 7940.2 7984.5 7987.4 8004.3 8005.6 8017.8 8023.6 7447.0 7643.5 7713.5 7715.0 7727.2 7516.5 7528.4 7553.7 7565.2 7584.5 7931.0 7955.1 7970.8 7998.2 7999.8 3988.5 4747.2 4792.8 4804.3 4870.8 7360.3 7602.0 7702.5 7725.3 7739.3 7381.1 7416.2 7421.3 7427.7 7430.3 7403.6 7409.3 7432.2 7438.3 7454.0 7003.5 7214.9 7247.3 7249.8 7269.6 7372.7 7413.1 7423.3 7429.0 7441.8 7213.6 7221.0 7229.4 7242.0 7243.5 11:11:35 INFO - PROCESS | 1674 | 11:11:35 INFO - PROCESS | 1674 | [#5] yui.html Cycles:180 Average:17669.88 Median:574.76 stddev:24218.71 (4213.7%) stddev-sans-first:24253.16 11:11:35 INFO - PROCESS | 1674 | Values: 706.9 725.0 732.8 759.0 765.1 14587.3 14734.9 14830.0 14833.6 14901.4 15740.0 16038.5 16050.8 16053.8 16086.8 783.0 953.2 965.3 974.5 974.6 902.6 952.5 964.1 964.6 966.0 956.7 995.7 1014.9 1017.0 1019.8 976.5 998.8 999.2 1001.9 1009.8 743.1 748.2 751.5 753.1 755.9 15170.7 15251.2 15264.6 15456.4 15536.3 12973.7 13001.0 13002.9 13125.7 13215.2 10019.9 10076.8 10107.4 10177.1 10346.4 3522.0 3547.6 3558.6 3663.8 3706.7 76615.9 76888.2 77285.5 77770.0 77984.6 7924.9 9340.5 9486.5 9555.4 9561.8 21251.5 21550.2 21604.9 21611.0 22023.2 7351.2 7454.6 7473.8 7475.1 7756.7 4023.7 4069.5 4075.9 4079.1 4080.7 3622.1 3638.8 3686.2 3690.0 3699.4 641.0 641.0 651.4 651.5 654.4 512.5 556.3 577.7 608.6 612.4 7160.9 7568.5 8064.3 8285.3 8650.8 523.5 571.6 571.8 623.1 635.5 3758.7 3775.5 3805.7 3866.0 3873.4 62931.7 83640.0 84967.7 85038.1 94214.0 70068.6 75223.0 76715.0 77155.2 78927.6 68784.3 68892.0 68938.7 70045.0 71051.0 6566.6 7562.8 7637.5 7777.4 7911.8 48188.8 48266.0 48564.3 49212.8 49983.3 49988.5 63929.7 63966.0 64255.0 67064.7 10056.4 10179.6 10855.2 11072.4 11542.4 11850.8 12046.8 12047.6 12105.0 12256.6 11052.0 11133.3 11409.6 11459.4 11522.9 11107.2 11173.1 11413.9 11489.8 11505.9 11020.6 11022.7 11029.4 11382.4 11404.1 9217.8 9252.5 9320.2 9516.7 9671.7 8913.8 9495.5 9516.6 9558.1 9623.8 11:11:35 INFO - PROCESS | 1674 | -------- Summary: end -------- 11:11:35 INFO - PROCESS | 1674 | 11:11:36 INFO - TEST-INFO | 1674: exit 0 11:11:36 INFO - TEST-OK | dromaeo_css | took 1111654ms 11:11:36 INFO - TEST-START | kraken 11:11:36 INFO - operating with platform_type : mac_ 11:11:36 INFO - Initialising browser for kraken test... 11:11:36 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/tmpowb7ry/profile http://localhost:49271/getInfo.html) 11:11:39 INFO - PROCESS | 1683 | __metrics Screen width/height:1600/1200 11:11:39 INFO - PROCESS | 1683 | colorDepth:24 11:11:39 INFO - PROCESS | 1683 | Browser inner width/height: 1024/689 11:11:39 INFO - PROCESS | 1683 | __metrics 11:11:39 ERROR - PROCESS | 1683 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 11:11:39 INFO - TEST-INFO | 1683: exit 0 11:11:39 INFO - Browser initialized. 11:11:39 INFO - Running cycle 1/1 for kraken test... 11:11:39 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/T/tmpowb7ry/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:11:52 INFO - PROCESS | 1686 | RSS: Main: 256483328 11:11:52 INFO - PROCESS | 1686 | 11:11:54 INFO - PROCESS | 1686 | 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) 11:11:55 INFO - PROCESS | 1686 | RSS: Main: 268738560 11:11:55 INFO - PROCESS | 1686 | 11:11:58 INFO - PROCESS | 1686 | 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) 11:11:58 INFO - PROCESS | 1686 | RSS: Main: 275972096 11:11:58 INFO - PROCESS | 1686 | 11:12:02 INFO - PROCESS | 1686 | 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) 11:12:02 INFO - PROCESS | 1686 | RSS: Main: 281231360 11:12:02 INFO - PROCESS | 1686 | 11:12:04 INFO - PROCESS | 1686 | 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) 11:12:05 INFO - PROCESS | 1686 | RSS: Main: 282726400 11:12:05 INFO - PROCESS | 1686 | 11:12:07 INFO - PROCESS | 1686 | 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) 11:12:08 INFO - PROCESS | 1686 | RSS: Main: 282177536 11:12:08 INFO - PROCESS | 1686 | 11:12:11 INFO - PROCESS | 1686 | 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) 11:12:11 INFO - PROCESS | 1686 | RSS: Main: 283738112 11:12:11 INFO - PROCESS | 1686 | 11:12:14 INFO - PROCESS | 1686 | 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) 11:12:15 INFO - PROCESS | 1686 | RSS: Main: 283627520 11:12:15 INFO - PROCESS | 1686 | 11:12:18 INFO - PROCESS | 1686 | 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) 11:12:18 INFO - PROCESS | 1686 | RSS: Main: 283975680 11:12:18 INFO - PROCESS | 1686 | 11:12:20 INFO - PROCESS | 1686 | 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) 11:12:20 INFO - PROCESS | 1686 | RSS: Main: 284311552 11:12:20 INFO - PROCESS | 1686 | 11:12:22 INFO - PROCESS | 1686 | 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) 11:12:23 INFO - PROCESS | 1686 | RSS: Main: 282238976 11:12:23 INFO - PROCESS | 1686 | 11:12:25 INFO - PROCESS | 1686 | 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) 11:12:26 INFO - PROCESS | 1686 | RSS: Main: 282509312 11:12:26 INFO - PROCESS | 1686 | 11:12:28 INFO - PROCESS | 1686 | 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) 11:12:29 INFO - PROCESS | 1686 | RSS: Main: 284536832 11:12:29 INFO - PROCESS | 1686 | 11:12:31 INFO - PROCESS | 1686 | 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) 11:12:32 INFO - PROCESS | 1686 | RSS: Main: 284016640 11:12:32 INFO - PROCESS | 1686 | 11:12:34 INFO - PROCESS | 1686 | 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) 11:12:34 INFO - PROCESS | 1686 | RSS: Main: 285609984 11:12:34 INFO - PROCESS | 1686 | 11:12:34 INFO - PROCESS | 1686 | __start_tp_report 11:12:34 INFO - PROCESS | 1686 | _x_x_mozilla_page_load 11:12:34 INFO - PROCESS | 1686 | _x_x_mozilla_page_load_details 11:12:34 INFO - PROCESS | 1686 | |i|pagename|runs| 11:12:34 INFO - PROCESS | 1686 | |0;ai-astar;116;87;168;168;145;125;116;115;114;115 11:12:34 INFO - PROCESS | 1686 | |1;audio-beat-detection;150;124;142;149;122;161;170;123;159;120 11:12:34 INFO - PROCESS | 1686 | |2;audio-dft;192;196;201;226;269;280;201;209;239;200 11:12:34 INFO - PROCESS | 1686 | |3;audio-fft;57;72;56;62;71;70;126;76;92;85 11:12:34 INFO - PROCESS | 1686 | |4;audio-oscillator;81;89;116;78;79;81;116;104;116;156 11:12:34 INFO - PROCESS | 1686 | |5;imaging-gaussian-blur;89;96;135;88;138;89;91;86;89;86 11:12:34 INFO - PROCESS | 1686 | |6;imaging-darkroom;95;142;95;139;150;119;95;96;94;96 11:12:34 INFO - PROCESS | 1686 | |7;imaging-desaturate;103;101;100;104;103;102;103;96;101;93 11:12:34 INFO - PROCESS | 1686 | |8;json-parse-financial;57;57;54;56;55;57;57;63;58;55 11:12:34 INFO - PROCESS | 1686 | |9;json-stringify-tinderbox;66;64;71;79;70;74;66;66;87;69 11:12:34 INFO - PROCESS | 1686 | |10;stanford-crypto-aes;82;85;87;84;85;71;99;106;112;111 11:12:34 INFO - PROCESS | 1686 | |11;stanford-crypto-ccm;154;117;118;147;139;138;134;125;125;141 11:12:34 INFO - PROCESS | 1686 | |12;stanford-crypto-pbkdf2;140;142;166;138;143;131;136;139;164;181 11:12:34 INFO - PROCESS | 1686 | |13;stanford-crypto-sha256-iterative;68;68;69;69;67;68;67;71;70;68 11:12:34 INFO - PROCESS | 1686 | __end_tp_report 11:12:34 INFO - PROCESS | 1686 | __start_cc_report 11:12:34 INFO - PROCESS | 1686 | _x_x_mozilla_cycle_collect,947 11:12:34 INFO - PROCESS | 1686 | __end_cc_report 11:12:34 INFO - PROCESS | 1686 | __startTimestamp1457809954516__endTimestamp 11:12:34 INFO - PROCESS | 1686 | 11:12:34 INFO - PROCESS | 1686 | ------- Summary: start ------- 11:12:34 INFO - PROCESS | 1686 | Number of tests: 14 11:12:34 INFO - PROCESS | 1686 | 11:12:34 INFO - PROCESS | 1686 | [#0] ai-astar Cycles:10 Average:126.90 Median:135.00 stddev:25.80 (19.1%) stddev-sans-first:27.06 11:12:34 INFO - PROCESS | 1686 | Values: 116.0 87.0 168.0 168.0 145.0 125.0 116.0 115.0 114.0 115.0 11:12:34 INFO - PROCESS | 1686 | 11:12:34 INFO - PROCESS | 1686 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:149.50 stddev:18.61 (12.4%) stddev-sans-first:19.51 11:12:34 INFO - PROCESS | 1686 | Values: 150.0 124.0 142.0 149.0 122.0 161.0 170.0 123.0 159.0 120.0 11:12:34 INFO - PROCESS | 1686 | 11:12:34 INFO - PROCESS | 1686 | [#2] audio-dft Cycles:10 Average:221.30 Median:217.50 stddev:31.59 (14.5%) stddev-sans-first:31.68 11:12:34 INFO - PROCESS | 1686 | Values: 192.0 196.0 201.0 226.0 269.0 280.0 201.0 209.0 239.0 200.0 11:12:34 INFO - PROCESS | 1686 | 11:12:34 INFO - PROCESS | 1686 | [#3] audio-fft Cycles:10 Average:76.70 Median:71.50 stddev:20.73 (29.0%) stddev-sans-first:20.72 11:12:34 INFO - PROCESS | 1686 | Values: 57.0 72.0 56.0 62.0 71.0 70.0 126.0 76.0 92.0 85.0 11:12:34 INFO - PROCESS | 1686 | 11:12:34 INFO - PROCESS | 1686 | [#4] audio-oscillator Cycles:10 Average:101.60 Median:78.50 stddev:25.08 (32.0%) stddev-sans-first:25.47 11:12:34 INFO - PROCESS | 1686 | Values: 81.0 89.0 116.0 78.0 79.0 81.0 116.0 104.0 116.0 156.0 11:12:34 INFO - PROCESS | 1686 | 11:12:34 INFO - PROCESS | 1686 | [#5] imaging-gaussian-blur Cycles:10 Average:98.70 Median:89.00 stddev:20.13 (22.6%) stddev-sans-first:21.05 11:12:34 INFO - PROCESS | 1686 | Values: 89.0 96.0 135.0 88.0 138.0 89.0 91.0 86.0 89.0 86.0 11:12:34 INFO - PROCESS | 1686 | 11:12:34 INFO - PROCESS | 1686 | [#6] imaging-darkroom Cycles:10 Average:112.10 Median:95.00 stddev:23.15 (24.4%) stddev-sans-first:23.72 11:12:34 INFO - PROCESS | 1686 | Values: 95.0 142.0 95.0 139.0 150.0 119.0 95.0 96.0 94.0 96.0 11:12:34 INFO - PROCESS | 1686 | 11:12:34 INFO - PROCESS | 1686 | [#7] imaging-desaturate Cycles:10 Average:100.60 Median:103.00 stddev:3.50 (3.4%) stddev-sans-first:3.61 11:12:34 INFO - PROCESS | 1686 | Values: 103.0 101.0 100.0 104.0 103.0 102.0 103.0 96.0 101.0 93.0 11:12:34 INFO - PROCESS | 1686 | 11:12:34 INFO - PROCESS | 1686 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.00 stddev:2.47 (4.3%) stddev-sans-first:2.62 11:12:34 INFO - PROCESS | 1686 | Values: 57.0 57.0 54.0 56.0 55.0 57.0 57.0 63.0 58.0 55.0 11:12:34 INFO - PROCESS | 1686 | 11:12:34 INFO - PROCESS | 1686 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:70.50 stddev:7.13 (10.1%) stddev-sans-first:7.31 11:12:34 INFO - PROCESS | 1686 | Values: 66.0 64.0 71.0 79.0 70.0 74.0 66.0 66.0 87.0 69.0 11:12:34 INFO - PROCESS | 1686 | 11:12:34 INFO - PROCESS | 1686 | [#10] stanford-crypto-aes Cycles:10 Average:92.20 Median:84.50 stddev:13.88 (16.4%) stddev-sans-first:14.22 11:12:34 INFO - PROCESS | 1686 | Values: 82.0 85.0 87.0 84.0 85.0 71.0 99.0 106.0 112.0 111.0 11:12:34 INFO - PROCESS | 1686 | 11:12:34 INFO - PROCESS | 1686 | [#11] stanford-crypto-ccm Cycles:10 Average:133.80 Median:138.50 stddev:12.32 (8.9%) stddev-sans-first:10.68 11:12:34 INFO - PROCESS | 1686 | Values: 154.0 117.0 118.0 147.0 139.0 138.0 134.0 125.0 125.0 141.0 11:12:34 INFO - PROCESS | 1686 | 11:12:34 INFO - PROCESS | 1686 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.00 Median:142.50 stddev:16.36 (11.5%) stddev-sans-first:17.09 11:12:34 INFO - PROCESS | 1686 | Values: 140.0 142.0 166.0 138.0 143.0 131.0 136.0 139.0 164.0 181.0 11:12:34 INFO - PROCESS | 1686 | 11:12:34 INFO - PROCESS | 1686 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:1.27 (1.9%) stddev-sans-first:1.33 11:12:34 INFO - PROCESS | 1686 | Values: 68.0 68.0 69.0 69.0 67.0 68.0 67.0 71.0 70.0 68.0 11:12:34 INFO - PROCESS | 1686 | -------- Summary: end -------- 11:12:34 INFO - PROCESS | 1686 | 11:12:35 INFO - TEST-INFO | 1686: exit 0 11:12:35 INFO - TEST-OK | kraken | took 59016ms 11:12:35 INFO - SUITE-END | took 1170s 11:12:35 INFO - Completed test suite (00:19:31) 11:12:35 INFO - javascript benchmark 11:12:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3497.090756403335, 3500.6674365935237, 3540.6990405815504, 3551.2897420515887, 3587.0852932502207, 5015.147424937761, 5751.798687045949, 5770.538356931446, 5796.362400135992, 5809.070548712201, 5636.718164091789, 5731.111677689954, 5750.0, 5796.5652576056755, 5891.440313170253, 4579.954200457986, 5171.405288391836, 5206.739663016853, 5222.921656175142, 5227.5295223429885, 4402.933955990663, 5240.947590524103, 5280.762365693534, 5300.973495132519, 5304.230886521452, 5124.743762811844, 5151.304573882534, 5203.063448579254, 5208.791648334062, 5264.499872512143, 5160.587153027749, 5189.7405129743365, 5217.217417387385, 5229.2417599448245, 5245.606579506552, 5133.178691409394, 5183.61122915779, 5192.3249977503065, 5192.688438693691, 5215.400228973679, 3932.429797679349, 5654.802081927113, 5728.398518155617, 5747.453991870808, 5793.304803423574, 6255.749770009194, 6322.430981211713, 6324.367563243685, 6331.303556608769, 6354.650494222816, 6114.7840275394365, 6276.184096067527, 6282.465990390822, 6330.430261276507, 6344.238691357021, 5942.732577034044, 5986.9401305986385, 5994.820155395345, 5999.0, 6038.0942858571125, 5622.297212848394, 6333.683315834282, 6354.777582784673, 6392.808215753535, 6399.296077431479, 4847.80608775652, 6079.361667024988, 6132.110843927606, 6271.123352936852, 6305.369463053658, 5119.795208191631, 6187.16473276111, 6313.589616674902, 6341.873162536724, 6368.936310636927, 5205.609579281569, 6213.130161777355, 6276.6547839869245, 6312.495000399957, 6326.335734747877, 5194.0, 6114.571104522756, 6140.688304616564, 6262.248530176408, 6293.5082358201735, 4960.355153829979, 4990.326305948651, 4996.750162491933, 5003.574696150868, 5053.292539044537, 4504.391907092566, 4508.45898492183, 4512.120136573402, 4526.751028693454, 4530.61489773373, 5748.223989761329, 5876.1479585459865, 5986.610870293417, 5998.4601385875485, 6011.819645410645, 6301.4328710416285, 6304.968475157595, 6318.684065796691, 6320.5259605528845, 6371.044343348535, 5882.294124705063, 5904.76380944766, 5913.46778789911, 5913.497352725067, 5916.1767192925345, 5350.919736203882, 5369.4362091980565, 5429.972850135724, 5456.699881506555, 5504.0, 6431.549791514549, 6445.742170313229, 6477.4494167996245, 6490.221173459215, 6490.383413575702, 6323.051542268512, 6325.304216536269, 6334.809955701337, 6352.078948552342, 6352.682365881595, 6194.938050619436, 6395.0, 6441.645709486023, 6504.4796416285635, 6507.28419873823, 6257.405546473078, 6309.274433440213, 6320.778772742932, 6323.988161894074, 6342.524310676626, 6198.907016394667, 6337.683115844282, 6340.71466784005, 6341.55609107358, 6351.301356850835, 6086.178365920544, 6118.497354392036, 6130.153553065376, 6227.595206311576, 6263.655498947602, 6265.27949285838, 6266.592671476339, 6274.152989346379, 6279.309275979547, 6285.96857015712, 4500.347449619721, 5405.594580406564, 6056.545759068, 6082.057281121433, 6129.0, 6049.606775559574, 6134.191681014119, 6185.0, 6215.850067737483, 6261.092141639346, 6097.298810636834, 6132.0, 6143.84640383994, 6148.415900489446, 6153.84615384619], "unit": "score", "name": "dojo.html", "value": 5724.508494083907}, {"lowerIsBetter": false, "replicates": [455.2965668042875, 495.44262704457486, 523.8637954131927, 599.970001499925, 602.632394239514, 30838.53742193866, 38613.613863861356, 38687.226255474874, 38720.0, 38799.41800872989, 32241.35517289653, 39205.0, 39711.0072248194, 39720.0, 39746.60253397465, 8341.874871876928, 9460.57427415768, 9612.615495380176, 9651.372660777062, 9768.804623907517, 8694.869576956351, 9771.0, 9773.169280611157, 9827.361221520578, 9854.359466634645, 9677.612895484208, 9723.902760972405, 9836.262280328969, 9857.753556161082, 9882.357646752975, 9739.902600974006, 9745.512724363789, 9854.852177217348, 9855.408675479493, 9873.506324683736, 9573.617055317849, 9700.223982081416, 9708.368956017835, 9708.514574271328, 9720.90279097207, 38723.225535489415, 38816.61183388186, 38874.61125388766, 39016.0, 39130.60869391298, 3244.0430073128246, 3290.8683652653867, 3536.2750636119536, 3850.614938506127, 3922.960770392288, 28283.434331313463, 29440.263993400335, 29677.258068548243, 29948.550771738443, 30452.8477357614, 2442.560339138954, 2755.875985580654, 2757.310672331917, 2770.667519897605, 2913.7086291370906, 492308.0, 498109.50945245405, 499189.0, 500104.49947750027, 500480.0, 45720.54279457163, 64673.35326646674, 65027.0, 65222.0, 65350.673246633465, 46849.5315046852, 47116.76441617838, 47662.523374766504, 47673.0, 47811.76094119507, 16341.101239431708, 16462.42381516641, 16525.0, 16549.338026478807, 16572.005679659258, 13122.671933201746, 13183.934080329536, 13270.0, 13272.535461258809, 13276.004299677563, 14815.703685926437, 14911.776323355158, 15021.324040418207, 15073.849261507465, 15162.545123646309, 6544.214694236627, 6736.8989465158065, 6764.120664313607, 6767.086443330186, 6771.28901465339, 881.8589025755977, 966.7438128895848, 982.6069572171189, 1046.2310202001522, 1050.8719842319213, 27886.0, 29331.85334073316, 29766.809327627085, 29798.95703650362, 29871.253218669706, 939.6570251858022, 1099.1591432554103, 1117.7038084907506, 1190.7261329894172, 1207.456644509974, 11965.581204657796, 14477.493287734878, 15148.772768408482, 15285.082895026335, 15399.846001539841, 608795.0, 620721.0, 634883.0, 638256.0, 639201.0, 54482.727586362606, 55723.885522289325, 56368.43631563714, 60737.0, 61964.69017654973, 1496.7904493370936, 1525.3364786317986, 1536.6849795791836, 1538.3846461415524, 1548.6670365871391, 29927.251818704706, 30671.079867604007, 30816.229594260323, 31244.843775780977, 31650.841745792044, 54131.72934135304, 54246.45753542572, 54422.72788636031, 54637.1804422926, 54712.0, 483728.0, 488716.0, 492677.0, 496741.0, 497575.0, 46304.768476157406, 47337.52662473469, 48064.75967620139, 48489.0, 49544.50455495399, 43258.35112473378, 45497.545024549334, 46009.929553170856, 46024.769876151746, 46438.071238575714, 37171.44242836306, 37975.810120949216, 37978.240435190586, 38110.42834357431, 38758.22483550369, 37445.6255437453, 37507.43738843974, 37553.0, 38020.42969355406, 38205.80897095497, 36622.63377366299, 36797.08007299839, 37186.25627487489, 37762.43356349602, 37779.81110094432, 32665.673343266262, 32973.0, 33029.834850825595, 33481.66518334785, 33542.49686254757, 24061.157859474835, 24867.50264994654, 25052.62421063649, 25235.11677091293, 25401.745982540677], "unit": "score", "name": "ext.html", "value": 19782.73835010651}, {"lowerIsBetter": false, "replicates": [361.26302343219817, 366.1541838353404, 372.0883834605217, 374.3916136278547, 375.1933343311879, 16098.35606575737, 19353.322633707823, 19734.21063157472, 19895.60208795827, 19958.301459448903, 17465.214065367058, 19822.702659460083, 20029.499262518446, 20711.482212944684, 20734.585308293863, 5659.462351076641, 5944.673042982634, 5980.192673989, 5992.34084250732, 5992.970035149818, 4199.727017743837, 5891.145783861338, 6203.596766210205, 6471.061696054069, 6477.708503117371, 6415.1339569158035, 6417.358264173592, 6417.39034791694, 6448.0, 6510.121133646944, 5494.09347457669, 5674.375818659964, 5714.085746280617, 5771.307443106812, 5791.681457519835, 5280.656757310762, 5442.564594832444, 5522.420145884665, 5527.474889885454, 5542.974549708277, 23260.883695581415, 23642.881785590962, 23670.0, 23737.525249495087, 24323.0, 2121.459027947879, 2218.3566765637947, 2254.447660323215, 2275.67002784597, 2682.208748419221, 8833.33749968755, 9662.13040826322, 10012.998700130001, 10027.147692446151, 10073.244506661957, 1341.3896677011935, 1594.234767311697, 1704.1564425609279, 1732.601501654614, 1733.5752740578512, 106521.46739266331, 106660.99999999923, 108356.4582177092, 108948.0, 109519.0, 10965.780684386267, 11187.888121118685, 11384.20310578268, 11402.543898243977, 11526.538938442536, 13599.048066635438, 13720.93139534316, 13729.0, 13761.587152385444, 13793.931030344784, 7960.0, 8463.661453541912, 8492.575371231414, 8610.268127209258, 8764.430312029697, 7281.490295679251, 8001.959990200012, 8767.21095101444, 8867.0, 8902.332325075646, 4397.450318710161, 4404.691671583022, 4460.420145381079, 4476.597106260387, 4493.033997690447, 1674.6232097778145, 1777.4667599720033, 1834.3322024440986, 1867.1037901806937, 1921.5868588253593, 784.8704963681043, 863.9654413823376, 963.2438535749403, 984.8178087053918, 1006.114619135171, 14630.634234144232, 20351.898240508704, 20363.4909127273, 20494.487637809176, 20649.96750162516, 948.1466679987929, 963.8120566489467, 975.9707208783748, 986.1765425869336, 1030.3302853145365, 9807.607695692235, 11013.504392302366, 11030.50362733679, 11037.0, 11047.613333533287, 213082.0, 213760.0, 214826.62933426476, 215185.0, 216232.8376716244, 115729.0, 117220.0, 117403.0, 118284.0, 121440.78559214472, 1008.0574662690408, 1009.6264382178641, 1016.0550687860214, 1028.573142146001, 1029.7322696099068, 18126.27494900189, 18271.908640456713, 18327.266909323476, 18407.355742548945, 18446.800957938227, 48975.75512122417, 49487.01025979532, 49872.0, 50145.0, 51337.0, 74430.31398915143, 74721.6263918677, 75532.0, 75729.86405204037, 77790.0, 7819.0, 7847.646855891385, 7921.366290696846, 7991.600419979094, 8013.959930200312, 11512.481938312963, 12348.0, 12433.502659893864, 12638.494460221487, 12651.87348126507, 9925.751856203364, 10299.794004120025, 10462.843057354297, 10739.838902416313, 10819.621313253998, 9777.315587908779, 10407.167426606005, 10572.735681608021, 10707.464626768786, 10930.836037459285, 9422.916364617882, 9793.118619324296, 10677.412742299248, 10876.619318324138, 11107.611233607107, 7728.652210650422, 7784.494007889695, 7963.402744794048, 7985.680572777256, 11093.50079246452, 10887.0, 10972.396518191257, 11014.504347304552, 11109.555617775522, 11157.884211578777], "unit": "score", "name": "jquery.html", "value": 9053.451216569194}, {"lowerIsBetter": false, "replicates": [1479.1494890437998, 1613.56433762884, 1905.1902941249973, 2003.889786061767, 2012.9396118116442, 7590.392768578514, 7983.9201607983905, 8712.56437178141, 8922.0, 8951.328650351217, 7387.8153046173875, 8561.657533698644, 8669.86995195071, 8776.868346974801, 8793.824123517526, 2448.9877550612223, 2465.506898620274, 2468.308873515419, 2468.4939587384633, 2469.0, 2426.0538390027905, 2459.7909177719916, 2478.355627536844, 2483.8758062096913, 2487.800975921931, 2045.1512622261744, 2408.6989126359204, 2439.1097249503982, 2439.841410308324, 2444.0, 2463.1748364297982, 2468.0127948820436, 2468.580341341967, 2487.117073438921, 2488.4525404411092, 2414.9615665263927, 2476.9752302476923, 2483.428811373394, 2490.2778194323623, 2493.4265119022543, 8890.288776897833, 8892.3330750194, 8936.32977526688, 8955.059718729504, 8988.32587555936, 5408.972955135238, 5528.226048353234, 5548.44515548446, 5555.611107222496, 5557.3886872444, 3558.3061303045915, 3656.6160553142067, 3670.394384926484, 3706.9073273168115, 3749.850005999757, 1048.2505008918583, 1067.8665166854144, 1072.2601405030505, 1072.745225489848, 1080.2924084724518, 11928.821067683904, 12045.457954392074, 12072.818907716304, 12084.033277337792, 12088.818667719992, 4904.068227036852, 4935.383077115361, 4943.209086546135, 4968.254761785689, 4973.42805577356, 10226.28416010872, 10226.6420675276, 10229.130523905551, 10240.539175737109, 10270.0, 5475.589330800206, 5511.53151982086, 5525.4474552544425, 5541.974734674018, 5560.805371811967, 4411.029573493826, 4873.610111191097, 4988.675736077216, 5002.799888004512, 5020.171671674133, 3921.352976758803, 3966.900827479336, 3971.8808435746973, 4003.4395184674167, 4027.496562929634, 1344.8520662727092, 1368.726254749054, 1369.1442848219863, 1380.7928810678277, 1380.9861901380857, 1355.5255660518937, 1382.7994940733538, 1384.1141669331637, 1399.7690381087211, 1415.0943396226423, 8206.425550211428, 8272.545010024385, 8296.294814940677, 8308.958455207685, 8344.707935222237, 502.53013432440787, 508.0372693745332, 515.28632843512, 517.3998162131909, 518.8599078248851, 6076.605020673642, 6143.170671959318, 6193.071039344044, 6195.349488303754, 6197.96901015492, 10223.488825558692, 10426.322289051188, 10426.843597346045, 10471.16230701542, 10534.420606866695, 10199.592016319413, 10276.948615256875, 10316.226283028653, 10335.328203666888, 10379.429131397694, 7601.315881570686, 7691.46159768822, 8001.359891208689, 8277.58612069394, 8282.8343433131, 7997.960010199912, 8094.231048050426, 8136.0, 8149.348052155695, 8168.550729709923, 9274.768130796783, 9428.292878034312, 9482.95258523703, 9558.665446709332, 9735.367201131903, 9595.568199430903, 9784.168345690412, 9800.411975281506, 9879.012098790063, 9990.750231244278, 6734.6632668367365, 7116.50184487081, 7393.9260607393235, 7542.208068152765, 7716.498427602188, 8178.754637360888, 8203.425760196968, 8249.422540422112, 8253.628586713492, 8301.792455188668, 7194.928050719426, 7242.529235599669, 7256.0, 7259.673314700745, 7466.440016998638, 7111.644417779194, 7138.39323657495, 7230.602316872622, 7288.96355518219, 7332.743353982585, 5869.941300586939, 7739.34215591681, 7825.960870195612, 7875.566843823644, 7989.360851131779, 6999.790006299819, 7025.508214424941, 7058.059033765756, 7088.432925365855, 7092.219855815753, 7068.71725130989, 7107.18267399235, 7155.284471553011, 7165.605891676008, 7175.964120179366], "unit": "score", "name": "mootools.html", "value": 4864.328904290837}, {"lowerIsBetter": false, "replicates": [326.10321615557217, 332.27066588837494, 334.54501877446654, 337.84625503904164, 339.6382852262339, 5589.496945274925, 6915.827104322394, 6932.965335173323, 6996.8950465743055, 7044.436445084394, 6839.076724642172, 6869.519133660633, 6939.028536004963, 6949.339812717783, 6967.79096627102, 4150.626443620066, 4839.830605928793, 4928.901421971558, 5041.546260836524, 5042.722650254234, 5019.824306149286, 5025.0, 5053.0, 5057.03916255912, 5062.848114556569, 4503.234450143484, 4511.887202819923, 4985.925211121836, 4987.451380348159, 4987.725675087869, 4993.550580447759, 5012.949870501303, 5034.270030845507, 5039.344885164942, 5043.5965122790085, 4328.783560821947, 4332.653387728974, 4343.500497442803, 4347.043650396908, 4360.454943132108, 6394.392532709432, 6654.2014958204845, 6700.262971073178, 6711.731530738764, 6749.6962636681465, 4452.821887124511, 5888.322842873082, 5916.083007133901, 5933.021051526493, 5935.2877654681715, 5971.790987315467, 7318.524295920748, 7367.557946523226, 7372.373348265404, 7376.815579610499, 4709.7174169549935, 4710.3405523226775, 4711.081339138869, 4723.740194289313, 4739.218029025206, 7304.5982470963545, 7693.615319234016, 7746.18665040174, 7751.22487751226, 7779.649915753805, 3920.941185882214, 4572.451305843254, 4644.349791029259, 4738.0, 4745.501722319176, 4821.300911367832, 4827.203511420576, 4827.589654879374, 4828.082664293773, 4846.491118432585, 4832.936753914133, 5741.85645358861, 5783.045797443375, 5785.971070144622, 5788.18965344852, 6753.425958793558, 6765.323467653294, 7305.525140865827, 7359.0, 7387.8153046174275, 1665.700173968673, 1688.9831101689072, 1692.7884014498188, 1695.5930576661513, 1698.2527687817567, 1043.9321444106108, 1067.492940853104, 1078.5092782783815, 1080.0, 1083.3391631105019, 6215.844603884849, 6784.287649796799, 6819.897701534481, 6822.4200942919415, 6864.313568643096, 7595.734149304748, 7606.603919765256, 7614.8096297593, 7630.923690763132, 7637.312641862259, 6075.210222671113, 6807.455403567703, 6825.317468253135, 6831.419329356961, 6831.9658401707675, 3763.6236376362695, 4052.2098190852503, 4053.250148722496, 4053.574374690674, 4058.066644671742, 7740.651670674721, 8029.518228906168, 8036.799080022929, 8059.717909873127, 8064.354851611857, 7885.6594378955715, 7914.327282181079, 7922.762317130495, 7940.16628254025, 7984.520928744178, 7987.3610111190965, 8004.279079997828, 8005.559694216874, 8017.759467215993, 8023.638936247883, 7446.962765186356, 7643.503172293783, 7713.498622589514, 7715.0, 7727.188645192174, 7516.5114267572435, 7528.435367347581, 7553.660085296065, 7565.167831538416, 7584.5070070445245, 7930.9603451982375, 7955.1249362568915, 7970.8007299815645, 7998.160193179632, 7999.800004999922, 3988.501437320335, 4747.240441529477, 4792.832250871203, 4804.342501836861, 4870.829520966749, 7360.33756961876, 7602.0, 7702.537847729154, 7725.304722574995, 7739.264769846855, 7381.11426628808, 7416.184219735716, 7421.332080112816, 7427.702891884264, 7430.294122058396, 7403.555786652818, 7409.259074092548, 7432.219616940143, 7438.293362130589, 7454.030975973089, 7003.509754317352, 7214.927850721426, 7247.347738703542, 7249.818754531179, 7269.619626873529, 7372.741954031583, 7413.1104267488245, 7423.331900129015, 7428.9628551856895, 7441.8139546511775, 7213.639318033972, 7220.963895180491, 7229.385502232369, 7242.0, 7243.529170603894], "unit": "score", "name": "prototype.html", "value": 5325.519370287898}, {"lowerIsBetter": false, "replicates": [706.8904319830426, 725.0, 732.7508647059999, 759.0, 765.1430397954289, 14587.34356953937, 14734.852651473482, 14830.0, 14833.629159271024, 14901.403943842246, 15740.0, 16038.518844434686, 16050.83949160508, 16053.759193612075, 16086.83913160868, 782.9725959591416, 953.2374100719431, 965.2760429677742, 974.5224839828469, 974.6442548469828, 902.620899222325, 952.5237381309346, 964.0504103458123, 964.6479035152154, 966.014665041657, 956.6795123633591, 995.6913356859396, 1014.8629934958797, 1016.9847452288221, 1019.7603563162651, 976.4824642939253, 998.8451789972494, 999.2355847776457, 1001.9098281154731, 1009.7677534167109, 743.0674503498076, 748.2181120728851, 751.4739682222412, 753.1075675324703, 755.8790593505067, 15170.696586068218, 15251.161186134868, 15264.618384540365, 15456.381744730197, 15536.300866461037, 12973.740525189538, 13001.0, 13002.934985325108, 13125.737485250242, 13215.20708757468, 10019.949900250525, 10076.798464030751, 10107.39355638664, 10177.134943529809, 10346.37921724699, 3522.0314413536485, 3547.627499112582, 3558.5729712434413, 3663.816809159531, 3706.684931780802, 76615.85076223861, 76888.23111768923, 77285.45429091387, 77770.0, 77984.61007694982, 7924.920750792534, 9340.532973351304, 9486.478243696663, 9555.426674399558, 9561.808763824685, 21251.46871328229, 21550.245741398976, 21604.891975540337, 21611.02750376237, 22023.22918697838, 7351.22812104732, 7454.552726836408, 7473.813154671177, 7475.0656167979005, 7756.728514502078, 4023.6982226333143, 4069.450624165759, 4075.918481630351, 4079.0618157823865, 4080.693947953856, 3622.1306886347616, 3638.7816730996224, 3686.225892562592, 3690.040589446763, 3699.352613292663, 640.9583377080475, 641.0416427441005, 651.364919203782, 651.5113664751436, 654.3652656922777, 512.5003121956138, 556.2712846171528, 577.708257330054, 608.5679167790829, 612.4295358062485, 7160.928390716131, 7568.508046976929, 8064.314533264738, 8285.25432711059, 8650.826983460296, 523.5445162708468, 571.6170165988798, 571.8198767388259, 623.1120653069358, 635.4820821030937, 3758.699304055669, 3775.4525593789294, 3805.6765174959883, 3865.9613403866165, 3873.438351439082, 62931.685341573, 83640.0, 84967.7254841178, 85038.14961850426, 94214.0, 70068.6496567514, 75223.0, 76715.0, 77155.2284477148, 78927.60536197282, 68784.31215687779, 68891.96662050074, 68938.65530672415, 70045.0, 71051.0, 6566.606003639797, 7562.774311050009, 7637.541747495168, 7777.4166937478785, 7911.762647120596, 48188.79528011828, 48266.0, 48564.2715359277, 49212.75393623152, 49983.25025124699, 49988.50011499839, 63929.68035159794, 63966.0, 64255.03617445649, 67064.66467667825, 10056.446895420822, 10179.592816287266, 10855.185861060294, 11072.446377681244, 11542.365169915734, 11850.822237666614, 12046.819297710717, 12047.578334758242, 12105.031597472358, 12256.571020014257, 11052.0385014419, 11133.317424332803, 11409.60066397672, 11459.427028648368, 11522.942385288019, 11107.222494425636, 11173.05029072538, 11413.885861141614, 11489.827652585385, 11505.884941150482, 11020.559177632806, 11022.669319920415, 11029.404477567577, 11382.373969431761, 11404.144689148181, 9217.76955576116, 9252.53737313145, 9320.161185493338, 9516.666916657883, 9671.70984870455, 8913.777155571162, 9495.525223738923, 9516.552366437812, 9558.091981261769, 9623.807523849624], "unit": "score", "name": "yui.html", "value": 6896.02276102156}], "name": "dromaeo_css", "value": 7536.031351215917}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 87.0, 168.0, 168.0, 145.0, 125.0, 116.0, 115.0, 114.0, 115.0], "unit": "score", "name": "ai-astar", "value": 126.9}, {"lowerIsBetter": true, "replicates": [150.0, 124.0, 142.0, 149.0, 122.0, 161.0, 170.0, 123.0, 159.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 142.0}, {"lowerIsBetter": true, "replicates": [192.0, 196.0, 201.0, 226.0, 269.0, 280.0, 201.0, 209.0, 239.0, 200.0], "unit": "score", "name": "audio-dft", "value": 221.3}, {"lowerIsBetter": true, "replicates": [57.0, 72.0, 56.0, 62.0, 71.0, 70.0, 126.0, 76.0, 92.0, 85.0], "unit": "score", "name": "audio-fft", "value": 76.7}, {"lowerIsBetter": true, "replicates": [81.0, 89.0, 116.0, 78.0, 79.0, 81.0, 116.0, 104.0, 116.0, 156.0], "unit": "score", "name": "audio-oscillator", "value": 101.6}, {"lowerIsBetter": true, "replicates": [89.0, 96.0, 135.0, 88.0, 138.0, 89.0, 91.0, 86.0, 89.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 98.7}, {"lowerIsBetter": true, "replicates": [95.0, 142.0, 95.0, 139.0, 150.0, 119.0, 95.0, 96.0, 94.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 112.1}, {"lowerIsBetter": true, "replicates": [103.0, 101.0, 100.0, 104.0, 103.0, 102.0, 103.0, 96.0, 101.0, 93.0], "unit": "score", "name": "imaging-desaturate", "value": 100.6}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 54.0, 56.0, 55.0, 57.0, 57.0, 63.0, 58.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.9}, {"lowerIsBetter": true, "replicates": [66.0, 64.0, 71.0, 79.0, 70.0, 74.0, 66.0, 66.0, 87.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.2}, {"lowerIsBetter": true, "replicates": [82.0, 85.0, 87.0, 84.0, 85.0, 71.0, 99.0, 106.0, 112.0, 111.0], "unit": "score", "name": "stanford-crypto-aes", "value": 92.2}, {"lowerIsBetter": true, "replicates": [154.0, 117.0, 118.0, 147.0, 139.0, 138.0, 134.0, 125.0, 125.0, 141.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 133.8}, {"lowerIsBetter": true, "replicates": [140.0, 142.0, 166.0, 138.0, 143.0, 131.0, 136.0, 139.0, 164.0, 181.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 69.0, 67.0, 68.0, 67.0, 71.0, 70.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1550.5000000000002}]} 11:12:35 INFO - Return code: 0 11:12:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:12:35 ERROR - # TBPL SUCCESS # 11:12:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:12:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:12:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:12:35 INFO - 2016-03-12 11:12:35.831 screenresolution[1691:10743] starting screenresolution argv=screenresolution get 11:12:35 INFO - 2016-03-12 11:12:35.833 screenresolution[1691:10743] Display 0: 1600x1200x32@60 11:12:35 INFO - 2016-03-12 11:12:35.839 screenresolution[1692:10746] starting screenresolution argv=screenresolution list 11:12:35 INFO - Available Modes on Display 0 11:12:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:12:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:12:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:12:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:12:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:12:36 INFO - Intel Iris: 11:12:36 INFO - Chipset Model: Intel Iris 11:12:36 INFO - Type: GPU 11:12:36 INFO - Bus: Built-In 11:12:36 INFO - VRAM (Dynamic, Max): 1536 MB 11:12:36 INFO - Vendor: Intel (0x8086) 11:12:36 INFO - Device ID: 0x0a2e 11:12:36 INFO - Revision ID: 0x0009 11:12:36 INFO - Displays: 11:12:36 INFO - Display: 11:12:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:12:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:12:36 INFO - Display Serial Number: 1600x1200 60 11:12:36 INFO - Main Display: Yes 11:12:36 INFO - Mirror: Off 11:12:36 INFO - Online: Yes 11:12:36 INFO - Rotation: Supported 11:12:36 INFO - Return code: 0 11:12:36 INFO - Running post-action listener: _resource_record_post_action 11:12:36 INFO - Running post-run listener: _resource_record_post_run 11:12:37 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 31415808; Write bytes: 708125184; Read time: 325; Write time: 2175 11:12:37 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 397566464; Write bytes: 391579136; Read time: 29941; Write time: 788 11:12:37 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 29634048; Write bytes: 303447040; Read time: 307; Write time: 1350 11:12:37 INFO - Running post-run listener: _upload_blobber_files 11:12:37 INFO - Blob upload gear active. 11:12:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:12:37 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 11:12:37 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'] 11:12:37 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 11:12:37 INFO - (blobuploader) - INFO - Open directory for files ... 11:12:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:12:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:12:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:38 INFO - (blobuploader) - INFO - Done attempting. 11:12:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:12:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:12:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:39 INFO - (blobuploader) - INFO - Done attempting. 11:12:39 INFO - (blobuploader) - INFO - Iteration through files over. 11:12:39 INFO - Return code: 0 11:12:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:12:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:12:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a946fb51575e5c0f2d40dcae49249b09c1d1f1488d934ca3c638b629fc3798c2c99411b1e4e60f9b0f0b31ad4a3a182815767f27d2978d4499e7ecf313972c3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24b946e0003ccc903f88c635e56ef0eabbffc2c4bbd254ab1bfb07dedadf48dbb086fcb415505ead23886b9b888fdf0b72a4a60ee0884c5697a41d3c201635b0"} 11:12:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:12:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:12:39 INFO - Contents: 11:12:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a946fb51575e5c0f2d40dcae49249b09c1d1f1488d934ca3c638b629fc3798c2c99411b1e4e60f9b0f0b31ad4a3a182815767f27d2978d4499e7ecf313972c3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24b946e0003ccc903f88c635e56ef0eabbffc2c4bbd254ab1bfb07dedadf48dbb086fcb415505ead23886b9b888fdf0b72a4a60ee0884c5697a41d3c201635b0"} 11:12:39 INFO - Running post-run listener: copy_logs_to_upload_dir 11:12:39 INFO - Copying logs to upload dir... 11:12:39 INFO - mkdir: /builds/slave/test/build/upload/logs 11:12:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1354.480577 ========= master_lag: 1.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 35 secs) (at 2016-03-12 11:12:40.518486) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-12 11:12:40.522381) ========= 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.7jdLhr7WUO/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.M9h9F3iPKe/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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/a946fb51575e5c0f2d40dcae49249b09c1d1f1488d934ca3c638b629fc3798c2c99411b1e4e60f9b0f0b31ad4a3a182815767f27d2978d4499e7ecf313972c3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24b946e0003ccc903f88c635e56ef0eabbffc2c4bbd254ab1bfb07dedadf48dbb086fcb415505ead23886b9b888fdf0b72a4a60ee0884c5697a41d3c201635b0"} build_url:https://queue.taskcluster.net/v1/task/G1WF6RILS7-vygX84T-eAA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011041 build_url: 'https://queue.taskcluster.net/v1/task/G1WF6RILS7-vygX84T-eAA/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/a946fb51575e5c0f2d40dcae49249b09c1d1f1488d934ca3c638b629fc3798c2c99411b1e4e60f9b0f0b31ad4a3a182815767f27d2978d4499e7ecf313972c3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24b946e0003ccc903f88c635e56ef0eabbffc2c4bbd254ab1bfb07dedadf48dbb086fcb415505ead23886b9b888fdf0b72a4a60ee0884c5697a41d3c201635b0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-12 11:12:40.557942) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 11:12:40.558278) ========= 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.7jdLhr7WUO/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.M9h9F3iPKe/Listeners TMPDIR=/var/folders/6k/3kgj72_n68j1r9bmpnhg097800000w/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.005219 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 11:12:40.607697) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-12 11:12:40.608209) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-12 11:12:40.608569) ========= ========= Total master_lag: 1.45 =========