builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0038 starttime: 1458163225.27 results: success (0) buildid: 20160316025750 builduid: a6bfc521402f4a5fa4eb8f83ce9a3aee revision: 341344bdec8f10bf50646cd6ef2355361435cbf6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 14:20:25.266052) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 14:20:25.266469) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 14:20:25.266765) ========= 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.spUWm4vWXM/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.fRhIL4QAfp/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.005925 basedir: '/builds/slave/test' ========= master_lag: 0.22 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 14:20:25.492228) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 11 secs) (at 2016-03-16 14:20:25.492497) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 11 secs) (at 2016-03-16 14:20:36.969482) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-03-16 14:20:36.969732) ========= 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.spUWm4vWXM/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.fRhIL4QAfp/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.005443 ========= master_lag: 1.64 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-03-16 14:20:38.615815) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 14:20:38.616093) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 14:20:38.616418) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 14:20:38.616688) ========= 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.spUWm4vWXM/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.fRhIL4QAfp/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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-16 14:20:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 11.7M=0.001s 2016-03-16 14:20:38 (11.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123741 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 14:20:38.822896) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 8 secs) (at 2016-03-16 14:20:38.823241) ========= 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.spUWm4vWXM/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.fRhIL4QAfp/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.020317 ========= master_lag: 8.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 8 secs) (at 2016-03-16 14:20:46.858855) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-03-16 14:20:46.859170) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 341344bdec8f10bf50646cd6ef2355361435cbf6 --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 341344bdec8f10bf50646cd6ef2355361435cbf6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.spUWm4vWXM/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.fRhIL4QAfp/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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-16 14:20:46,947 truncating revision to first 12 chars 2016-03-16 14:20:46,947 Setting DEBUG logging. 2016-03-16 14:20:46,947 attempt 1/10 2016-03-16 14:20:46,947 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/341344bdec8f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-16 14:20:47,550 unpacking tar archive at: mozilla-central-341344bdec8f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.849971 ========= master_lag: 4.82 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-03-16 14:20:52.525088) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-03-16 14:20:52.525451) ========= echo 341344bdec8f10bf50646cd6ef2355361435cbf6 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'341344bdec8f10bf50646cd6ef2355361435cbf6'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.spUWm4vWXM/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.fRhIL4QAfp/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 341344bdec8f10bf50646cd6ef2355361435cbf6 program finished with exit code 0 elapsedTime=0.005284 script_repo_revision: '341344bdec8f10bf50646cd6ef2355361435cbf6' ========= master_lag: 1.74 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-03-16 14:20:54.266796) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 5 secs) (at 2016-03-16 14:20:54.267084) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 5 secs) (at 2016-03-16 14:20:59.601819) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-03-16 14:20:59.602302) ========= /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.spUWm4vWXM/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.fRhIL4QAfp/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 14:21:00 INFO - MultiFileLogger online at 20160316 14:21:00 in /builds/slave/test 14:21:00 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 14:21:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:21:00 INFO - {'append_to_log': False, 14:21:00 INFO - 'base_work_dir': '/builds/slave/test', 14:21:00 INFO - 'blob_upload_branch': 'Firefox', 14:21:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:21:00 INFO - 'branch': 'Firefox', 14:21:00 INFO - 'buildbot_json_path': 'buildprops.json', 14:21:00 INFO - 'config_files': ('talos/mac_config.py',), 14:21:00 INFO - 'default_actions': ('clobber', 14:21:00 INFO - 'read-buildbot-config', 14:21:00 INFO - 'download-and-extract', 14:21:00 INFO - 'populate-webroot', 14:21:00 INFO - 'create-virtualenv', 14:21:00 INFO - 'install', 14:21:00 INFO - 'run-tests'), 14:21:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:21:00 INFO - 'download_minidump_stackwalk': True, 14:21:00 INFO - 'download_symbols': 'ondemand', 14:21:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:21:00 INFO - 'tooltool.py': '/tools/tooltool.py', 14:21:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:21:00 INFO - '/tools/misc-python/virtualenv.py')}, 14:21:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:21:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:21:00 INFO - 'installer_path': 'installer.exe', 14:21:00 INFO - 'log_level': 'info', 14:21:00 INFO - 'log_name': 'talos', 14:21:00 INFO - 'log_to_console': True, 14:21:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:21:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:21:00 INFO - 'opt_config_files': (), 14:21:00 INFO - 'pip_index': False, 14:21:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:21:00 INFO - 'cmd': ('bash', 14:21:00 INFO - '-c', 14:21:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:21:00 INFO - 'enabled': True, 14:21:00 INFO - 'halt_on_failure': False, 14:21:00 INFO - 'name': 'check_screen_resolution'},), 14:21:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:21:00 INFO - 'cmd': ('bash', 14:21:00 INFO - '-c', 14:21:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:21:00 INFO - 'enabled': True, 14:21:00 INFO - 'halt_on_failure': False, 14:21:00 INFO - 'name': 'check_screen_resolution'},), 14:21:00 INFO - 'run_cmd_checks_enabled': True, 14:21:00 INFO - 'sps_profile': False, 14:21:00 INFO - 'sps_profile_interval': 0, 14:21:00 INFO - 'suite': 'dromaeojs-e10s', 14:21:00 INFO - 'system_bits': '32', 14:21:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:21:00 INFO - 'title': 't-yosemite-r7-0038', 14:21:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:21:00 INFO - 'use_talos_json': True, 14:21:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:21:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:21:00 INFO - 'work_dir': 'build'} 14:21:00 INFO - ##### 14:21:00 INFO - ##### Running clobber step. 14:21:00 INFO - ##### 14:21:00 INFO - Running pre-action listener: _resource_record_pre_action 14:21:00 INFO - Running main action method: clobber 14:21:00 INFO - rmtree: /builds/slave/test/build 14:21:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:21:01 INFO - Running post-action listener: _resource_record_post_action 14:21:01 INFO - ##### 14:21:01 INFO - ##### Running read-buildbot-config step. 14:21:01 INFO - ##### 14:21:01 INFO - Running pre-action listener: _resource_record_pre_action 14:21:01 INFO - Running main action method: read_buildbot_config 14:21:01 INFO - Using buildbot properties: 14:21:01 INFO - { 14:21:01 INFO - "project": "", 14:21:01 INFO - "product": "firefox", 14:21:01 INFO - "script_repo_revision": "production", 14:21:01 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 14:21:01 INFO - "repository": "", 14:21:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 14:21:01 INFO - "buildid": "20160316025750", 14:21:01 INFO - "pgo_build": "False", 14:21:01 INFO - "basedir": "/builds/slave/test", 14:21:01 INFO - "buildnumber": 143, 14:21:01 INFO - "slavename": "t-yosemite-r7-0038", 14:21:01 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 14:21:01 INFO - "platform": "yosemite_r7", 14:21:01 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 14:21:01 INFO - "branch": "mozilla-central", 14:21:01 INFO - "repo_path": "mozilla-central", 14:21:01 INFO - "revision": "341344bdec8f10bf50646cd6ef2355361435cbf6", 14:21:01 INFO - "stage_platform": "macosx64", 14:21:01 INFO - "builduid": "a6bfc521402f4a5fa4eb8f83ce9a3aee", 14:21:01 INFO - "slavebuilddir": "test" 14:21:01 INFO - } 14:21:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 14:21:01 INFO - Running post-action listener: _resource_record_post_action 14:21:01 INFO - ##### 14:21:01 INFO - ##### Running download-and-extract step. 14:21:01 INFO - ##### 14:21:01 INFO - Running pre-action listener: _resource_record_pre_action 14:21:01 INFO - Running main action method: download_and_extract 14:21:01 INFO - mkdir: /builds/slave/test/build/tests 14:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:01 INFO - https://queue.taskcluster.net/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:21:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 14:21:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 14:21:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/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 14:21:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/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 14:21:03 INFO - Downloaded 1199 bytes. 14:21:03 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 14:21:03 INFO - Using the following test package requirements: 14:21:03 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 14:21:03 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:21:03 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 14:21:03 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:21:03 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 14:21:03 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:21:03 INFO - u'jsshell-mac.zip'], 14:21:03 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:21:03 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 14:21:03 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 14:21:03 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:21:03 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 14:21:03 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:21:03 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 14:21:03 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:21:03 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 14:21:03 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:21:03 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 14:21:03 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:21: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')]} 14:21:03 INFO - https://queue.taskcluster.net/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:21:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:21:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:21:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/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 14:21:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/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 14:21:05 INFO - Downloaded 17854313 bytes. 14:21:05 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'] 14:21:05 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 14:21:08 INFO - Return code: 0 14:21:08 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 14:21:08 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')]} 14:21:08 INFO - https://queue.taskcluster.net/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:21:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:21:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:21:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/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 14:21:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/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 14:21:12 INFO - Downloaded 17854313 bytes. 14:21:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:21:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:21:16 INFO - Return code: 0 14:21:16 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')]} 14:21:16 INFO - https://queue.taskcluster.net/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:21:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 14:21:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 14:21:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/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 14:21:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/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 14:21:17 INFO - Downloaded 10846462 bytes. 14:21:17 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'] 14:21:17 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 14:21:17 INFO - Return code: 0 14:21:17 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')]} 14:21:17 INFO - https://queue.taskcluster.net/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:21:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:21:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:21:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 14:21:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/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 14:21:20 INFO - Downloaded 111192012 bytes. 14:21:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:21:20 INFO - mkdir: /builds/slave/test/properties 14:21:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:21:20 INFO - Writing to file /builds/slave/test/properties/build_url 14:21:20 INFO - Contents: 14:21:20 INFO - build_url:https://queue.taskcluster.net/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:21:21 INFO - Running post-action listener: _resource_record_post_action 14:21:21 INFO - Running post-action listener: set_extra_try_arguments 14:21:21 INFO - ##### 14:21:21 INFO - ##### Running populate-webroot step. 14:21:21 INFO - ##### 14:21:21 INFO - Running pre-action listener: _resource_record_pre_action 14:21:21 INFO - Running main action method: populate_webroot 14:21:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:21:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:21:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:21:21 INFO - '--tppagecycles', 14:21:21 INFO - '7'], 14:21:21 INFO - 'tests': ['tsvgm']}}, 14:21:21 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:21:21 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:21:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:21:21 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:21:21 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:21:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:21:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:21:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:21 INFO - 'talos_options': ['--e10s'], 14:21:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:21:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:21 INFO - 'tests': ['damp', 'tps']}, 14:21:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:21 INFO - 'talos_options': ['--e10s'], 14:21:21 INFO - 'tests': ['damp', 'tps']}, 14:21:21 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:21:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:21:21 INFO - 'other': {'tests': ['a11yr', 14:21:21 INFO - 'ts_paint', 14:21:21 INFO - 'tpaint', 14:21:21 INFO - 'sessionrestore', 14:21:21 INFO - 'sessionrestore_no_auto_restore', 14:21:21 INFO - 'tabpaint']}, 14:21:21 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:21:21 INFO - 'tests': ['a11yr', 14:21:21 INFO - 'ts_paint', 14:21:21 INFO - 'tpaint', 14:21:21 INFO - 'sessionrestore', 14:21:21 INFO - 'sessionrestore_no_auto_restore', 14:21:21 INFO - 'tabpaint']}, 14:21:21 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:21:21 INFO - 'tests': ['a11yr', 14:21:21 INFO - 'ts_paint', 14:21:21 INFO - 'tpaint', 14:21:21 INFO - 'sessionrestore', 14:21:21 INFO - 'sessionrestore_no_auto_restore', 14:21:21 INFO - 'tabpaint']}, 14:21:21 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:21:21 INFO - 'tests': ['a11yr', 14:21:21 INFO - 'ts_paint', 14:21:21 INFO - 'tpaint', 14:21:21 INFO - 'sessionrestore', 14:21:21 INFO - 'sessionrestore_no_auto_restore', 14:21:21 INFO - 'tabpaint']}, 14:21:21 INFO - 'other_l64': {'tests': ['a11yr', 14:21:21 INFO - 'ts_paint', 14:21:21 INFO - 'tpaint', 14:21:21 INFO - 'sessionrestore', 14:21:21 INFO - 'sessionrestore_no_auto_restore', 14:21:21 INFO - 'tabpaint']}, 14:21:21 INFO - 'other_nol64': {'tests': ['a11yr', 14:21:21 INFO - 'ts_paint', 14:21:21 INFO - 'tpaint', 14:21:21 INFO - 'sessionrestore', 14:21:21 INFO - 'sessionrestore_no_auto_restore', 14:21:21 INFO - 'tabpaint']}, 14:21:21 INFO - 'svgr': {'tests': ['tsvgx', 14:21:21 INFO - 'tsvgr_opacity', 14:21:21 INFO - 'tart', 14:21:21 INFO - 'tscrollx', 14:21:21 INFO - 'cart']}, 14:21:21 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:21:21 INFO - 'tests': ['tsvgx', 14:21:21 INFO - 'tsvgr_opacity', 14:21:21 INFO - 'tart', 14:21:21 INFO - 'tscrollx', 14:21:21 INFO - 'cart']}, 14:21:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:21 INFO - 'tests': ['tp5o']}, 14:21:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:21 INFO - 'talos_options': ['--e10s'], 14:21:21 INFO - 'tests': ['tp5o']}, 14:21:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:21 INFO - 'talos_options': ['--xperf_path', 14:21:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:21:21 INFO - 'tests': ['tp5n']}, 14:21:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:21 INFO - 'talos_options': ['--e10s', 14:21:21 INFO - '--xperf_path', 14:21:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:21:21 INFO - 'tests': ['tp5n']}}, 14:21:21 INFO - 'talos.zip': {'path': '', 14:21:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:21:21 INFO - Running post-action listener: _resource_record_post_action 14:21:21 INFO - ##### 14:21:21 INFO - ##### Running create-virtualenv step. 14:21:21 INFO - ##### 14:21:21 INFO - Running pre-action listener: _resource_record_pre_action 14:21:21 INFO - Running main action method: create_virtualenv 14:21:21 INFO - Creating virtualenv /builds/slave/test/build/venv 14:21:21 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 14:21:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:21:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:21:21 INFO - Using real prefix '/tools/python27' 14:21:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:21:22 INFO - Installing distribute.............................................................................................................................................................................................done. 14:21:25 INFO - Installing pip.................done. 14:21:25 INFO - Return code: 0 14:21:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:21:25 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')]} 14:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:25 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')]} 14:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:25 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 0x102120a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021274c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc43d87f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fc4d30>, '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 0x101de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fbbb20>, '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.spUWm4vWXM/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.fRhIL4QAfp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 14:21:25 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 14:21:25 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 14:21:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.spUWm4vWXM/Render', 14:21:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:25 INFO - 'HOME': '/Users/cltbld', 14:21:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:25 INFO - 'LOGNAME': 'cltbld', 14:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:25 INFO - 'MOZ_NO_REMOTE': '1', 14:21:25 INFO - 'NO_EM_RESTART': '1', 14:21:25 INFO - 'PAGER': '/bin/cat', 14:21:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:25 INFO - 'PWD': '/builds/slave/test', 14:21:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:25 INFO - 'SHELL': '/bin/bash', 14:21:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fRhIL4QAfp/Listeners', 14:21:25 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 14:21:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:25 INFO - 'USER': 'cltbld', 14:21:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:25 INFO - 'XPC_FLAGS': '0x0', 14:21:25 INFO - 'XPC_SERVICE_NAME': '0', 14:21:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:25 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 14:21:25 INFO - Cleaning up... 14:21:25 INFO - Return code: 0 14:21:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:21:25 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')]} 14:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:25 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')]} 14:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:25 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 0x102120a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021274c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc43d87f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fc4d30>, '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 0x101de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fbbb20>, '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.spUWm4vWXM/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.fRhIL4QAfp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 14:21:25 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 14:21:25 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 14:21:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.spUWm4vWXM/Render', 14:21:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:25 INFO - 'HOME': '/Users/cltbld', 14:21:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:25 INFO - 'LOGNAME': 'cltbld', 14:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:25 INFO - 'MOZ_NO_REMOTE': '1', 14:21:25 INFO - 'NO_EM_RESTART': '1', 14:21:25 INFO - 'PAGER': '/bin/cat', 14:21:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:25 INFO - 'PWD': '/builds/slave/test', 14:21:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:25 INFO - 'SHELL': '/bin/bash', 14:21:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fRhIL4QAfp/Listeners', 14:21:25 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 14:21:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:25 INFO - 'USER': 'cltbld', 14:21:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:25 INFO - 'XPC_FLAGS': '0x0', 14:21:25 INFO - 'XPC_SERVICE_NAME': '0', 14:21:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:25 INFO - Downloading/unpacking psutil>=0.7.1 14:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:21:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:21:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:21:28 INFO - Installing collected packages: psutil 14:21:28 INFO - Running setup.py install for psutil 14:21:29 INFO - building 'psutil._psutil_osx' extension 14:21:29 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 14:21:29 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 14:21:29 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 14:21:29 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 14:21:29 INFO - building 'psutil._psutil_posix' extension 14:21:29 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 14:21:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:21:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:21:29 INFO - ^ 14:21:29 INFO - 1 warning generated. 14:21:29 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 14:21:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:21:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:21:29 INFO - Successfully installed psutil 14:21:29 INFO - Cleaning up... 14:21:29 INFO - Return code: 0 14:21:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:29 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 0x102120a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021274c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc43d87f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fc4d30>, '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 0x101de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fbbb20>, '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.spUWm4vWXM/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.fRhIL4QAfp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 14:21:29 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 14:21:29 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 14:21:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.spUWm4vWXM/Render', 14:21:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:29 INFO - 'HOME': '/Users/cltbld', 14:21:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:29 INFO - 'LOGNAME': 'cltbld', 14:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:29 INFO - 'MOZ_NO_REMOTE': '1', 14:21:29 INFO - 'NO_EM_RESTART': '1', 14:21:29 INFO - 'PAGER': '/bin/cat', 14:21:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:29 INFO - 'PWD': '/builds/slave/test', 14:21:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:29 INFO - 'SHELL': '/bin/bash', 14:21:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fRhIL4QAfp/Listeners', 14:21:29 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 14:21:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:29 INFO - 'USER': 'cltbld', 14:21:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:29 INFO - 'XPC_FLAGS': '0x0', 14:21:29 INFO - 'XPC_SERVICE_NAME': '0', 14:21:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:21:30 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 14:21:30 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 14:21:30 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 14:21:30 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 14:21:30 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 14:21:30 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 14:21:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:21:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:21:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:21:32 INFO - Installing collected packages: mozsystemmonitor 14:21:32 INFO - Running setup.py install for mozsystemmonitor 14:21:32 INFO - Successfully installed mozsystemmonitor 14:21:32 INFO - Cleaning up... 14:21:32 INFO - Return code: 0 14:21:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:21:32 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')]} 14:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:32 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')]} 14:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:32 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 0x102120a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021274c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc43d87f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fc4d30>, '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 0x101de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fbbb20>, '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.spUWm4vWXM/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.fRhIL4QAfp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 14:21:32 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 14:21:32 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 14:21:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.spUWm4vWXM/Render', 14:21:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:32 INFO - 'HOME': '/Users/cltbld', 14:21:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:32 INFO - 'LOGNAME': 'cltbld', 14:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:32 INFO - 'MOZ_NO_REMOTE': '1', 14:21:32 INFO - 'NO_EM_RESTART': '1', 14:21:32 INFO - 'PAGER': '/bin/cat', 14:21:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:32 INFO - 'PWD': '/builds/slave/test', 14:21:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:32 INFO - 'SHELL': '/bin/bash', 14:21:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fRhIL4QAfp/Listeners', 14:21:32 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 14:21:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:32 INFO - 'USER': 'cltbld', 14:21:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:32 INFO - 'XPC_FLAGS': '0x0', 14:21:32 INFO - 'XPC_SERVICE_NAME': '0', 14:21:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:32 INFO - Downloading/unpacking blobuploader==1.2.4 14:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:35 INFO - Downloading blobuploader-1.2.4.tar.gz 14:21:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:21:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:21:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:36 INFO - Downloading docopt-0.6.1.tar.gz 14:21:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:21:36 INFO - Installing collected packages: blobuploader, requests, docopt 14:21:36 INFO - Running setup.py install for blobuploader 14:21:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:21:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:21:36 INFO - Running setup.py install for requests 14:21:37 INFO - Running setup.py install for docopt 14:21:37 INFO - Successfully installed blobuploader requests docopt 14:21:37 INFO - Cleaning up... 14:21:37 INFO - Return code: 0 14:21:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102120a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021274c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc43d87f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fc4d30>, '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 0x101de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fbbb20>, '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.spUWm4vWXM/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.fRhIL4QAfp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 14:21:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:21:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:21:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.spUWm4vWXM/Render', 14:21:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:37 INFO - 'HOME': '/Users/cltbld', 14:21:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:37 INFO - 'LOGNAME': 'cltbld', 14:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:37 INFO - 'MOZ_NO_REMOTE': '1', 14:21:37 INFO - 'NO_EM_RESTART': '1', 14:21:37 INFO - 'PAGER': '/bin/cat', 14:21:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:37 INFO - 'PWD': '/builds/slave/test', 14:21:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:37 INFO - 'SHELL': '/bin/bash', 14:21:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fRhIL4QAfp/Listeners', 14:21:37 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 14:21:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:37 INFO - 'USER': 'cltbld', 14:21:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:37 INFO - 'XPC_FLAGS': '0x0', 14:21:37 INFO - 'XPC_SERVICE_NAME': '0', 14:21:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:21:37 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-aIVbPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:21:37 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-hKrgIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:21:37 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-vtAqEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:21:38 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-LkQoH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:21:38 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-Sx4qOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:21:38 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-w1D7SH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:21:38 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-r9hzMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:21:38 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-9G4nIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:21:38 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-iom956-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:21:38 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-I8bYBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:21:38 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-ULCTyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:21:38 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-ztBTTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:21:39 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-7BrPYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:21:39 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-p6_0Cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:21:39 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-bvAI8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:21:39 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-t_Je4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:21:39 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-4LVTzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:21:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:21:39 INFO - Running setup.py install for manifestparser 14:21:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:21:39 INFO - Running setup.py install for mozcrash 14:21:39 INFO - Running setup.py install for mozdebug 14:21:39 INFO - Running setup.py install for mozdevice 14:21:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:21:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:21:40 INFO - Running setup.py install for mozfile 14:21:40 INFO - Running setup.py install for mozhttpd 14:21:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:21:40 INFO - Running setup.py install for mozinfo 14:21:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:21:40 INFO - Running setup.py install for mozInstall 14:21:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:21:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:21:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:21:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:21:40 INFO - Running setup.py install for mozleak 14:21:40 INFO - Running setup.py install for mozlog 14:21:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:21:41 INFO - Running setup.py install for moznetwork 14:21:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:21:41 INFO - Running setup.py install for mozprocess 14:21:41 INFO - Running setup.py install for mozprofile 14:21:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:21:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:21:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:21:41 INFO - Running setup.py install for mozrunner 14:21:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:21:41 INFO - Running setup.py install for mozscreenshot 14:21:41 INFO - Running setup.py install for moztest 14:21:41 INFO - Running setup.py install for mozversion 14:21:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:21:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:21:42 INFO - Cleaning up... 14:21:42 INFO - Return code: 0 14:21:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:21:42 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')]} 14:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:42 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')]} 14:21:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:42 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 0x102120a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021274c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc43d87f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fc4d30>, '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 0x101de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fbbb20>, '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.spUWm4vWXM/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.fRhIL4QAfp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 14:21:42 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 14:21:42 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 14:21:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.spUWm4vWXM/Render', 14:21:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:42 INFO - 'HOME': '/Users/cltbld', 14:21:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:42 INFO - 'LOGNAME': 'cltbld', 14:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:42 INFO - 'MOZ_NO_REMOTE': '1', 14:21:42 INFO - 'NO_EM_RESTART': '1', 14:21:42 INFO - 'PAGER': '/bin/cat', 14:21:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:42 INFO - 'PWD': '/builds/slave/test', 14:21:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:42 INFO - 'SHELL': '/bin/bash', 14:21:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fRhIL4QAfp/Listeners', 14:21:42 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 14:21:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:42 INFO - 'USER': 'cltbld', 14:21:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:42 INFO - 'XPC_FLAGS': '0x0', 14:21:42 INFO - 'XPC_SERVICE_NAME': '0', 14:21:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:21:42 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-8jcLyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:21:42 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-V42jfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:21:42 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-PCgjqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:21:42 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-J8BsxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:21:42 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-OPdSeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:21:42 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-QNB8iS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:21:42 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-obOR_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:21:43 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)) 14:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:21:43 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-954P8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:21:43 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)) 14:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:21:43 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-ZaWBzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:21:43 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-m7JoHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:21:43 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-_KPpLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:21:43 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-H3_MWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:21:43 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-Hypojx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:21:43 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-GfuwHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:21:43 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-XvKr3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:21:43 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-QCzhjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:21:44 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)) 14:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:21:44 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-dW2JIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:21:44 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)) 14:21:44 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)) 14:21:44 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)) 14:21:44 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)) 14:21:44 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)) 14:21:44 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)) 14:21:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:46 INFO - Downloading blessings-1.6.tar.gz 14:21:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:21:46 INFO - Installing collected packages: blessings 14:21:46 INFO - Running setup.py install for blessings 14:21:46 INFO - Successfully installed blessings 14:21:46 INFO - Cleaning up... 14:21:46 INFO - Return code: 0 14:21:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:21:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:21:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:21:47 INFO - Reading from file tmpfile_stdout 14:21:47 INFO - Current package versions: 14:21:47 INFO - blessings == 1.6 14:21:47 INFO - blobuploader == 1.2.4 14:21:47 INFO - docopt == 0.6.1 14:21:47 INFO - manifestparser == 1.1 14:21:47 INFO - mozInstall == 1.12 14:21:47 INFO - mozcrash == 0.17 14:21:47 INFO - mozdebug == 0.1 14:21:47 INFO - mozdevice == 0.48 14:21:47 INFO - mozfile == 1.2 14:21:47 INFO - mozhttpd == 0.7 14:21:47 INFO - mozinfo == 0.9 14:21:47 INFO - mozleak == 0.1 14:21:47 INFO - mozlog == 3.1 14:21:47 INFO - moznetwork == 0.27 14:21:47 INFO - mozprocess == 0.22 14:21:47 INFO - mozprofile == 0.28 14:21:47 INFO - mozrunner == 6.11 14:21:47 INFO - mozscreenshot == 0.1 14:21:47 INFO - mozsystemmonitor == 0.0 14:21:47 INFO - moztest == 0.7 14:21:47 INFO - mozversion == 1.4 14:21:47 INFO - psutil == 3.1.1 14:21:47 INFO - requests == 1.2.3 14:21:47 INFO - wsgiref == 0.1.2 14:21:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102120a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021274c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc43d87f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fc4d30>, '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 0x101de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fbbb20>, '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.spUWm4vWXM/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.fRhIL4QAfp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 14:21:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:21:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.spUWm4vWXM/Render', 14:21:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:47 INFO - 'HOME': '/Users/cltbld', 14:21:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:47 INFO - 'LOGNAME': 'cltbld', 14:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:47 INFO - 'MOZ_NO_REMOTE': '1', 14:21:47 INFO - 'NO_EM_RESTART': '1', 14:21:47 INFO - 'PAGER': '/bin/cat', 14:21:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:47 INFO - 'PWD': '/builds/slave/test', 14:21:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:47 INFO - 'SHELL': '/bin/bash', 14:21:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fRhIL4QAfp/Listeners', 14:21:47 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 14:21:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:47 INFO - 'USER': 'cltbld', 14:21:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:47 INFO - 'XPC_FLAGS': '0x0', 14:21:47 INFO - 'XPC_SERVICE_NAME': '0', 14:21:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:21:47 INFO - Cleaning up... 14:21:47 INFO - Return code: 0 14:21:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102120a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021274c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc43d87f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fc4d30>, '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 0x101de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fbbb20>, '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.spUWm4vWXM/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.fRhIL4QAfp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 14:21:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:21:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.spUWm4vWXM/Render', 14:21:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:47 INFO - 'HOME': '/Users/cltbld', 14:21:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:47 INFO - 'LOGNAME': 'cltbld', 14:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:47 INFO - 'MOZ_NO_REMOTE': '1', 14:21:47 INFO - 'NO_EM_RESTART': '1', 14:21:47 INFO - 'PAGER': '/bin/cat', 14:21:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:47 INFO - 'PWD': '/builds/slave/test', 14:21:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:47 INFO - 'SHELL': '/bin/bash', 14:21:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fRhIL4QAfp/Listeners', 14:21:47 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 14:21:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:47 INFO - 'USER': 'cltbld', 14:21:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:47 INFO - 'XPC_FLAGS': '0x0', 14:21:47 INFO - 'XPC_SERVICE_NAME': '0', 14:21:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:47 INFO - Downloading/unpacking jsonschema 14:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:21:50 INFO - Downloading/unpacking functools32 (from jsonschema) 14:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:50 INFO - Downloading functools32-3.2.3-2.tar.gz 14:21:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:21:50 INFO - warning: no files found matching '*.txt' 14:21:50 INFO - no previously-included directories found matching 'build' 14:21:50 INFO - no previously-included directories found matching 'dist' 14:21:50 INFO - no previously-included directories found matching '.git*' 14:21:50 INFO - Installing collected packages: jsonschema, functools32 14:21:50 INFO - Running setup.py install for functools32 14:21:50 INFO - warning: no files found matching '*.txt' 14:21:50 INFO - no previously-included directories found matching 'build' 14:21:50 INFO - no previously-included directories found matching 'dist' 14:21:50 INFO - no previously-included directories found matching '.git*' 14:21:50 INFO - Successfully installed jsonschema functools32 14:21:50 INFO - Cleaning up... 14:21:50 INFO - Return code: 0 14:21:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:21:50 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')]} 14:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:50 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')]} 14:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:50 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 0x102120a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021274c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc43d87f60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fc4d30>, '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 0x101de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fbbb20>, '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.spUWm4vWXM/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.fRhIL4QAfp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 14:21:50 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 14:21:50 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 14:21:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.spUWm4vWXM/Render', 14:21:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:50 INFO - 'HOME': '/Users/cltbld', 14:21:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:50 INFO - 'LOGNAME': 'cltbld', 14:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:50 INFO - 'MOZ_NO_REMOTE': '1', 14:21:50 INFO - 'NO_EM_RESTART': '1', 14:21:50 INFO - 'PAGER': '/bin/cat', 14:21:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:50 INFO - 'PWD': '/builds/slave/test', 14:21:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:50 INFO - 'SHELL': '/bin/bash', 14:21:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fRhIL4QAfp/Listeners', 14:21:50 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 14:21:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:50 INFO - 'USER': 'cltbld', 14:21:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:50 INFO - 'XPC_FLAGS': '0x0', 14:21:50 INFO - 'XPC_SERVICE_NAME': '0', 14:21:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:51 INFO - Downloading/unpacking flake8 14:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:21:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:21:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:21:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:21:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:21:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:21:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:21:54 INFO - no previously-included directories found matching 'docs/_build' 14:21:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:21:54 INFO - Running setup.py install for pep8 14:21:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:21:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:21:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:21:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:21:54 INFO - no previously-included directories found matching 'docs/_build' 14:21:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:21:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:21:54 INFO - Cleaning up... 14:21:54 INFO - Return code: 0 14:21:54 INFO - Running post-action listener: _resource_record_post_action 14:21:54 INFO - Running post-action listener: _start_resource_monitoring 14:21:55 INFO - Starting resource monitoring. 14:21:55 INFO - ##### 14:21:55 INFO - ##### Running install step. 14:21:55 INFO - ##### 14:21:55 INFO - Running pre-action listener: _resource_record_pre_action 14:21:55 INFO - Running main action method: install 14:21:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:21:55 INFO - Reading from file tmpfile_stdout 14:21:55 INFO - Detecting whether we're running mozinstall >=1.0... 14:21:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:21:55 INFO - Reading from file tmpfile_stdout 14:21:55 INFO - Output received: 14:21:55 INFO - Usage: mozinstall [options] installer 14:21:55 INFO - Options: 14:21:55 INFO - -h, --help show this help message and exit 14:21:55 INFO - -d DEST, --destination=DEST 14:21:55 INFO - Directory to install application into. [default: 14:21:55 INFO - "/builds/slave/test"] 14:21:55 INFO - --app=APP Application being installed. [default: firefox] 14:21:55 INFO - mkdir: /builds/slave/test/build/application 14:21:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:22:28 INFO - Reading from file tmpfile_stdout 14:22:28 INFO - Output received: 14:22:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:22:28 INFO - Running post-action listener: _resource_record_post_action 14:22:28 INFO - ##### 14:22:28 INFO - ##### Running run-tests step. 14:22:28 INFO - ##### 14:22:28 INFO - Running pre-action listener: _resource_record_pre_action 14:22:28 INFO - Running main action method: run_tests 14:22:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:22:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:22:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:22:28 INFO - 2016-03-16 14:22:28.814 screenresolution[2265:17793] starting screenresolution argv=screenresolution get 14:22:28 INFO - 2016-03-16 14:22:28.817 screenresolution[2265:17793] Display 0: 1600x1200x32@60 14:22:28 INFO - 2016-03-16 14:22:28.823 screenresolution[2266:17796] starting screenresolution argv=screenresolution list 14:22:28 INFO - Available Modes on Display 0 14:22:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:22:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:22:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:22:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:22:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:22:29 INFO - Intel Iris: 14:22:29 INFO - Chipset Model: Intel Iris 14:22:29 INFO - Type: GPU 14:22:29 INFO - Bus: Built-In 14:22:29 INFO - VRAM (Dynamic, Max): 1536 MB 14:22:29 INFO - Vendor: Intel (0x8086) 14:22:29 INFO - Device ID: 0x0a2e 14:22:29 INFO - Revision ID: 0x0009 14:22:29 INFO - Displays: 14:22:29 INFO - Display: 14:22:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:22:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:22:29 INFO - Display Serial Number: 1600x1200 60 14:22:29 INFO - Main Display: Yes 14:22:29 INFO - Mirror: Off 14:22:29 INFO - Online: Yes 14:22:29 INFO - Rotation: Supported 14:22:29 INFO - Return code: 0 14:22:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:22:29 INFO - Python 2.7.3 14:22:29 INFO - Return code: 0 14:22:29 INFO - grabbing minidump binary from tooltool 14:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fc4d30>, '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 0x101de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fbbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:22:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:22:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:22:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:22:29 INFO - Return code: 0 14:22:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:22:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:22:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:22:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:22:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:22:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:22:30 INFO - Return code: 0 14:22:30 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/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--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 14:22:30 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/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0038 --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 14:22:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.spUWm4vWXM/Render', 14:22:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:30 INFO - 'HOME': '/Users/cltbld', 14:22:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:30 INFO - 'LOGNAME': 'cltbld', 14:22:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:22:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:22:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:30 INFO - 'MOZ_NO_REMOTE': '1', 14:22:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:22:30 INFO - 'NO_EM_RESTART': '1', 14:22:30 INFO - 'PAGER': '/bin/cat', 14:22:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:30 INFO - 'PWD': '/builds/slave/test', 14:22:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:22:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:30 INFO - 'SHELL': '/bin/bash', 14:22:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fRhIL4QAfp/Listeners', 14:22:30 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 14:22:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:30 INFO - 'USER': 'cltbld', 14:22:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:30 INFO - 'XPC_FLAGS': '0x0', 14:22:30 INFO - 'XPC_SERVICE_NAME': '0', 14:22:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:30 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/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--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 14:22:30 INFO - mozversion application_buildid: 20160316025750 14:22:30 INFO - mozversion application_changeset: 341344bdec8f10bf50646cd6ef2355361435cbf6 14:22:30 INFO - mozversion application_display_name: Nightly 14:22:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:22:30 INFO - mozversion application_name: Firefox 14:22:30 INFO - mozversion application_remotingname: firefox 14:22:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:22:30 INFO - mozversion application_vendor: Mozilla 14:22:30 INFO - mozversion application_version: 48.0a1 14:22:30 INFO - mozversion platform_buildid: 20160316025750 14:22:30 INFO - mozversion platform_changeset: 341344bdec8f10bf50646cd6ef2355361435cbf6 14:22:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:22:30 INFO - mozversion platform_version: 48.0a1 14:22:30 INFO - using testdate: 1458163350 14:22:30 INFO - actual date: 1458163350 14:22:30 INFO - starting webserver on 'localhost:50049' 14:22:30 INFO - SUITE-START | Running 2 tests 14:22:30 INFO - TEST-START | dromaeo_css 14:22:30 INFO - operating with platform_type : mac_ 14:22:30 INFO - Initialising browser for dromaeo_css test... 14:22:30 INFO - TEST-INFO | started process 2284 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpZT86zb/profile http://localhost:50049/getInfo.html) 14:22:32 INFO - PROCESS | 2284 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 14:22:33 INFO - PROCESS | 2284 | __metrics Screen width/height:1600/1200 14:22:33 INFO - PROCESS | 2284 | colorDepth:24 14:22:33 INFO - PROCESS | 2284 | Browser inner width/height: 1024/689 14:22:33 INFO - PROCESS | 2284 | __metrics 14:22:33 ERROR - PROCESS | 2284 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 14:22:33 INFO - TEST-INFO | 2284: exit 0 14:22:33 INFO - Browser initialized. 14:22:33 INFO - Running cycle 1/1 for dromaeo_css test... 14:22:33 INFO - TEST-INFO | started process 2288 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpZT86zb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:22:46 INFO - PROCESS | 2288 | RSS: Main: 256667648 14:22:46 INFO - PROCESS | 2288 | 14:23:35 INFO - PROCESS | 2288 | 1458163415734 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] 14:25:45 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:50049/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50049/tests/dromaeo/cssquery-ext.html) 14:25:46 INFO - PROCESS | 2288 | RSS: Main: 269312000 14:25:46 INFO - PROCESS | 2288 | 14:28:48 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:50049/tests/dromaeo/cssquery-ext.html (next: http://localhost:50049/tests/dromaeo/cssquery-jquery.html) 14:28:49 INFO - PROCESS | 2288 | RSS: Main: 281726976 14:28:49 INFO - PROCESS | 2288 | 14:31:50 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:50049/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50049/tests/dromaeo/cssquery-mootools.html) 14:31:51 INFO - PROCESS | 2288 | RSS: Main: 282226688 14:31:51 INFO - PROCESS | 2288 | 14:34:53 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:50049/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50049/tests/dromaeo/cssquery-prototype.html) 14:34:53 INFO - PROCESS | 2288 | RSS: Main: 283299840 14:34:53 INFO - PROCESS | 2288 | 14:37:56 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:50049/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50049/tests/dromaeo/cssquery-yui.html) 14:37:57 INFO - PROCESS | 2288 | RSS: Main: 287391744 14:37:57 INFO - PROCESS | 2288 | 14:40:59 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:50049/tests/dromaeo/cssquery-yui.html (next: http://localhost:50049/tests/dromaeo/cssquery-dojo.html) 14:40:59 INFO - PROCESS | 2288 | RSS: Main: 288653312 14:40:59 INFO - PROCESS | 2288 | 14:40:59 INFO - PROCESS | 2288 | __start_tp_report 14:40:59 INFO - PROCESS | 2288 | _x_x_mozilla_page_load 14:40:59 INFO - PROCESS | 2288 | _x_x_mozilla_page_load_details 14:40:59 INFO - PROCESS | 2288 | |i|pagename|runs| 14:40:59 INFO - PROCESS | 2288 | |0;dojo.html;3117.5791268178796;3477.095955051686;3501.842417091231;3511.420615598425;3567.429211326188;5724.141378793178;5769.221155144054;5777.971110144454;5782.103773915044;5808.012637851565;5540.252065971093;5806.071028635419;5874.206982057421;5878.823635290948;5911.85220369491;5118.07874582575;5161.690298582078;5225.843224703265;5241.659292146017;5273.525382715555;33.67541742981462;5226.947730522703;5237.162054071349;5334.919976200341;5411.323584551931;5142.820001299955;5221.765020574065;5229.1633338666015;5245.6852588844795;5273.2617433559335;4418.381426600278;5271.841844744664;5278.264472298352;5279.1817268323475;5332.946670533283;5023.547880690755;5169.586433085344;5202.141646628302;5251.632385733;5271.998320319127;5472.50747432729;5581.916271255935;5623.690697011662;5667.489925906688;5680.005998950209;6149.477294429978;6203.038529028008;6203.131561581382;6207.4723648489935;6212.627242365473;5125.666831655931;6156;6191.938080619181;6206.069089636546;6242.438180563771;5403.648762830403;5896.204012458306;5899.882002359972;5918.437748413937;5923.259592550931;6028.216331876915;6284.842878928063;6295.559310848196;6302.023186406114;6340.270868850049;5249.028929648028;6018.337982821886;6123.571350005457;6196.10156527301;6196.504279657616;6169.2288463942;6224.844378890564;6241.407066328691;6253.155823963798;6259.123722678829;6115.602485838406;6216.875662486816;6226.906596401058;6258.780942666985;6281.937180628135;6145.432914606747;6220.657863817533;6257.937420625826;6270.278917924497;6278.748850046039;4180.790960452026;4658.930116048195;4886.438059623118;4936.234883593049;4953.108440480748;4319.589638984291;4382.890427739332;4436.401085853433;4459;4470.932936005963;5623.803166889221;5766.826995190151;5808.215890854765;5928.703564821828;5959.255093113361;5678.4037676044245;5870.14882841994;6187.474064704551;6201.929555743067;6214.471769899609;5727.083666613322;5880.7353669085;5893.44012318829;5894.852628684317;5917.260342457193;4104.4664193654635;5351.491608297206;5352.2506849041165;5401.135818269058;5462.344518657707;5877.617954832922;6310.1796766420075;6327.715252813635;6332.873342533124;6340.904886426707;6116.305337586134;6125.296497837281;6202.658853762906;6210.068489726577;6210.130581718473;6316.11574379578;6395.93604063972;6419.518536109717;6424.2933277338525;6428.035794630843;6094.634321940698;6097.664628445478;6100.420460056465;6112.083187521907;6113.266408031065;6063.120847477179;6123.540734445023;6135.631862088289;6137.539684523589;6141.447269745744;6013.188219590299;6053.182820319376;6069.238496484001;6085.756569737338;6104.816855494342;5933.673647949404;6064.120702498201;6088.056351265561;6126.142340072304;6145.508359331154;5805.896879592864;5995.700214989321;6027.397260273938;6037.637741735334;6053.939460605337;6004.87990240184;6142.723577438936;6150.04674275488;6150.354212807591;6156.846078848064;5540.36285827135;5951.018082016419;6009.639421634716;6010.909836352545;6017.638941663514 14:40:59 INFO - PROCESS | 2288 | |1;ext.html;458.16842430987754;483.15447966059395;581.4592429040993;595.2797115490257;652.3411354531922;37971.430428543594;38619;38821.80589097054;38851.80574097126;38964.61035389645;34300.65699343006;40152;40183.79448616539;40338.99152521188;40427;9495;9665.46839923804;9710.805783884318;9716.65991690291;9733.075357840993;9461.526923653824;9712.805743885117;9723.854142187873;9781.168600668952;9781.804363912717;9718.757031074245;9760.219182465386;9787.608495660164;9838.016198380175;9841.606335746561;9684.515774211297;9751.21990240779;9779.364341317792;9785.559649815776;9809.362391444532;8317.542535160565;8913.910860891438;9733.513324333755;9778.951105244429;9791.412515249036;31962.680373196203;39293.41059884104;39449.60550394488;39465.605343946765;39575.60424395748;3113.692249255318;3215.9678403216135;3232.612086549629;3366.7306615470948;3518.032541051206;23116.76883231163;27214.591781123298;28302.292442688893;28517.714822851714;28562;2720.7007229204773;2786.456640955015;2798.790090743202;2799.1322689966178;2912.956305655417;440848;446507;449983.99999999674;451631;454718;45643;63116.68441657762;63404.68297658575;63408.68295658492;63598.728025440156;42487.787561062614;45811.083778324246;46067.84830379267;46173.769131154804;46448;15926.442574509836;16106;16163.838361616468;16194.59513512148;16204.75692864608;12926.806097908539;12939.676508087374;12941;12949.54676586315;13006.349682515836;14643.48747793822;14761.630959225891;14826.481073162387;14830.480933167288;14831.406743730346;5269.631125821233;5551.833444996657;6430.453411460078;6548.886689262837;6556.475481961432;916.326500022483;1061.984070238947;1085.9701581351042;1107.9667609971714;1144.8969592736694;25307.240782776178;30060.54909176364;30260.394792104475;30325.393492130035;30406.391872162432;1098.8516550265772;1107.534835369147;1121.971950701239;1132.1621999720312;1166.6266794625637;13006.739865202642;15217.239138043053;15269.694606108038;15519.068855868683;15640.139792311533;561112;564381;570682;570761;571108;60417;60625.69687151536;60911.69544152251;61086.69456652688;61189;1390.3395886953615;1441.099312929419;1469.0304399096544;1474.852514748538;1482.8665420112027;29502.55746163766;29614;29664.034680291377;30285.848570757003;30305.393892122476;51058.74470627623;51465.97068058543;51607.225891610906;51908;51922.22116668329;520121;523343;524579.7542024531;526596.3670181625;527214;34289.31421371608;34772;43600;44910.3263451055;46345.304820427045;45734.54265457436;46046.7697661523;46359.768201158775;46711.29933050939;46809.531904680516;37216.6278337224;37991.67029153966;38128.809355953046;38265.23469530649;38907.02732431598;37399.065023374635;37583.40955779844;37645.24709505849;38082.2383552333;38571.421428679154;34291.31417371589;37999.62000379961;38342.041448964;38730.6126938727;39112.217755645295;30916.22709432282;32104;32226.35547289088;32320.676793232706;32375;24273.029078836647;24779.88490517895;24799.00803967821;25726.228213153634;26113.474680917832 14:40:59 INFO - PROCESS | 2288 | |2;jquery.html;319.2290618157152;338.726388778194;372.2294849661201;376.8285430129291;379.6052105809956;19890.20439182433;20381.777093374407;20821.375358739242;21258;21296.148154073857;20193.49516262094;20384.592308153828;20577.897110514463;21402.501824872266;21441.57116857662;5639.802606908759;5820.825375238739;5971.5222782177325;6018.247719035121;6023.72893219804;4266.7866606669695;5545.251391062196;6345.71444285006;6640.435562977153;6646.302138275484;6507.577007494498;6561.376669216417;6579.407853293203;6582.736690532373;6584.9012264816065;6294.968525157391;6458.483321334282;6516.511261655347;6525.249596296439;6579.671016449182;5503.724813759296;5525.751341189616;5570.777168913239;5580.079286917654;5584.86037849053;26046.869765651052;26225.73774262252;26245.343866403302;26554.93780248788;26639.33401664974;2125.2455378340774;2127.5319429725437;2149.151085321305;2304.182015384548;2900.1734505665786;9381.671641492516;9642.228621710246;9811.950940245324;14939.925300373538;15525.922370388076;1768.3015208992376;1788.8211178882138;1826.2421095245456;1833.8257865502756;1876.5265394467717;104926;110520;111049.44475277571;112001;115064;11133.332000080021;11207.215494915441;11208.495617697223;11365.659030229106;11412.717456508732;13643.522476713268;13679.384427700777;13686.04197706151;13703.109297895606;13733.176009439267;6987.825304367329;8662.696805611773;8705.91294087051;8742.431741936754;8828.028916819145;8826.779330516789;8890.73327800167;8937.46375217489;8980.371374003887;8999.37004409698;4394.780260986938;4485.663575231871;4494.4606647202545;4518.186726389215;4530.139273538017;1621.5135459362143;1708.7522309265087;1758.639478906821;1896.8672192946638;1910.1022519415853;968.5157421289356;988.6094992477931;1033.8190816607214;1053.1943063556384;1068.8509851909228;19606.411807645793;20857.165713371294;21475;21503.784962150177;21637;965.9130678238993;1010.7422607235255;1013.6604237580345;1016.7204018894863;1070.7376692710336;10821.891781082246;11129.888701113046;11224.66326010221;11255.212135150625;11255.887441125647;574712;667095;673286;676074;686629;120191.19713204309;120857.79142208642;121588;123982;124578.37710811388;1062.3041907550567;1069.9679009629724;1079.0342643334172;1079.3847506921136;1099.126194675219;18919.716204257224;19015.049247537292;19091.140898659873;19237.903810480857;19250.326238581583;52126;52554;52854;53023.40929772113;54361.456385437225;74595;75471;75782.48435031378;77459.45081098459;77679.61160194162;7702.884456733042;7853.8036549084445;7882;7932.722354717557;7941.967544219215;11027.61403350911;12603.873961260637;12832.101752877208;12841.165324253894;12946.611601651966;10400.791984160425;10736.141108711441;10741.516631751747;10947.726306842074;11102.666919992413;10196.541155647865;10687.679369618923;10805.135589152691;10980.945095274472;11000.22998390137;10974.890251097706;11216.943915280372;11264.098872090377;11342.319460832046;11448.771024579295;7822.882656760039;7845.411594130349;7880.093789214314;7979.72070977513;8095.5142691438705;7604.80987975305;7848.960755196187;8070.435069545076;8359.373047021376;8395.70615028471 14:40:59 INFO - PROCESS | 2288 | |3;mootools.html;1585.0885740699098;1602.1588665950378;1907.5517253445437;1978.7526559180103;1991.9203231870717;7660.693572257117;8365.539895305756;8449.155084491555;8621.008584012841;8635.30917526598;8445.28215101717;8459.11179326171;8543.871841922377;8565.314774818014;8566.742997710064;2473.9876300618516;2487.800975921931;2492.4516606346574;2498.350428888493;2510.3598582361474;2135.6155891939443;2426.9393265168424;2482.950340993188;2492.8255022148455;2497.400623850272;2463.741307162749;2471.8022558195303;2477.1453848422266;2499.5375855466705;2500.9749902501017;2464.7781699647117;2471.876406179693;2489.9253022409357;2492.339530024527;2492.3644470660047;2453.141400509825;2476.2942561370105;2483.0936708101594;2486.3784053986506;2492.140211626986;8588.227059564606;8588.441751286146;8617.913820861773;8636.222739953435;8719.389642725011;5253.711045892474;5350.357957045179;5380.677159370451;5403.054465468566;5435.565154787608;3288.3752087103376;3530.293941211768;3636.254567813592;3676.9816150919073;3701.444783282502;1066.5413872035022;1077.9819938187748;1085.9022687958043;1086.266769930294;1086.315621158673;9756.975517570623;11278.718032049264;11280.492377843017;11363.772724545546;11410.771784564262;4494.258447356215;4526.140033393644;4780.139574876555;4835.516448355136;4886.364772579613;9857;9857.901420985841;9885.752856178653;9896;9905;5410.3507579090765;5422.349318081855;5434.619576629598;5444.074507333763;5467.043267428184;4333.848315308949;4770.308305295713;4866.075445665312;4869.220924652039;4945.233488809168;3829.540455145345;3908.5700572936953;3922.666573341298;3941.8620348287673;3965.583613720518;1311.3967574915646;1319.346923272967;1322.4379638653534;1325.1982550556968;1340.7251513439721;1186.792311345511;1364.6861221919014;1398.7622104242303;1409.5771268619578;1415.9079659822078;7921.603919804102;7926.643301051467;7946.483478573874;7961.442699011013;7968.880466793003;507.11761534928957;519.4156573854414;524.5122036506086;524.9186376111709;526.2133110999005;6079.270487541435;6157.538184636171;6157.9384206157365;6214.5960512566535;6224.221972253468;10127.291089623655;10339.9483002586;10435.739106522398;10475.790484190273;10514.001169888848;9712.22302215821;10229.079382855578;10252.38485690861;10284.537195826206;10317.380957142444;7937.960310198412;8065.838683226302;8074.636641351271;8148.674053037812;8152.021757389032;7843.803904902423;7868.055833299812;7925.207479252259;7933.3653307734085;7958.3235424989525;7562.621868906643;8941.910580894108;9133.543322833964;9167.724968250963;9293.628254869729;9218.585163667785;9477.052294770469;9504.714858554255;9627.181689556466;9675.951620241854;6623.072769812326;7099.893501597377;7303.780886573411;7357.779266621796;7518.624068796429;7425.777226683208;7702.729049706735;8119.228673276029;8157.143499932422;8159.9800024996875;7203.387712044325;7298.37963773064;7314.963425183053;7417.554946703215;7445.143808461879;6942.757003504853;7048.083749112582;7064.858702826017;7158.46311526648;7231.566106033655;7461.216572259835;7489.101307843093;7533.773986780406;7548.698052077855;7567.356774674215;6811.250762416229;6851.965740171467;6854.965725171542;6873.931260687529;6893.689783959834;6828.692708828214;6938.479614029069;6950.3049695030095;6966.303369662993;7026.473014523829 14:40:59 INFO - PROCESS | 2288 | |4;prototype.html;315.14595446340417;336.9932601347973;337.13188539510764;340.92158803475195;342.33074339665956;6845.760398386057;6965.1990021147585;6970.198427180876;6994.510384273103;7013.29867013299;6908.309169083102;6913.861722765541;6915;6921;6925.757598484054;4791.640626952975;4899.387576552931;5046.596272298208;5102.591792656597;5114.923276150861;5044.066847633199;5073.162928116874;5097.133487307148;5133.383993920716;5145.3311069560905;4073;5047.974760126194;5081.136206844845;5101.54086132248;5103.213875143707;4135.58644135587;5071.366079240095;5072.721000344998;5077.060743762398;5077.111505486543;4340.8697739067875;4353.477582690066;4360.563943605645;4363.869083927487;4369.71596846204;6023.427774361428;6051.576389652726;6312.305646378894;6696.330366963313;6704.83237919051;5798.869220502003;5847.8538036549;5849;5856.857912707023;5870.706464676792;5959.493443057346;5993.550483713695;7304.634768261566;7352.926470735278;7374.041374621265;4664.976675116636;4670.719756814602;4673.228917228653;4675.1818431774645;4676.7427791471455;7374.373178279852;7726.420518461138;7815;7839.1768864269;7850.6859725611475;4486.955130448719;4624.907501849944;4720.079584480994;4723.197056500403;4723.858284251478;4831.758412079382;4838.685485443505;4841.249606310957;4841.830535931225;4870.512948705172;4812.230043193073;5807.216025836543;5819.621724587888;5829.242198514251;5838.357780644125;7380.151282602462;7396.704131834774;7397.593132377663;7412.369948554326;7446;1660.4769497608215;1685.957851053709;1686.5193419875277;1689.695854746133;1695.4998275508754;1036.388530766851;1077.0468135699805;1077.380506208933;1082.6643740440488;1086.9891301087046;6917.342852429011;6921.653917304115;6935.410490108397;6949.478789090838;6951.617661028692;5448.42791506894;6182.845428864314;7618.847623047508;7652.923470765221;7654.693812247448;6871.553349032297;6878.621675807779;6879.105716256855;6885.690143943534;6890.724371025203;3224.967750322514;3231.4829627259523;4057.3102572562734;4064.695147863922;4074.6332830044844;5904.321003084614;7873.488223265469;7887.645055972495;8037.638306276232;8041.557714325651;6783.118194634666;7826.921730782733;7892.4080693947035;8010.839783204303;8045.678172873019;6518.934810651927;6924.549904256308;8129.674813007532;8140.715074972348;8143.3485321172975;7432.925670743223;7699.306152646409;7724.536527808349;7740.961295193713;7752.341051010501;7532.17146113938;7556.6977320908745;7565.43259255547;7572.318491335806;7585;6955.374016338554;8104.351651867954;8105.8378832424205;8109.02691676979;8113.594320283844;3947.4276229947072;4627.5141110184295;4740.170470167775;4756.762161891822;4760;6464.8707025858275;7196.280371962971;7274.527155734861;7678.424118191047;7708.421868359784;6574.980877963923;6851.691673874788;7388.187299397169;7404.925950740424;7416;7389.8522029558035;7406.666699998621;7411.332980031823;7415.703371865281;7417.480776345604;7171.211166771546;7177;7185.353318201178;7196.640167991684;7218.819529511804;7191.316824901626;7411.518251313647;7422.220666829905;7438.293362130589;7447;7177.784666460015;7230.385417239383;7234.710611575478;7256.129264488084;7262.491625586158 14:40:59 INFO - PROCESS | 2288 | |5;yui.html;721.9747308844192;758.8406434648723;767.2940894377174;783.7100272899024;801.8035581282587;15116.773248401269;15242.085474871516;15354.155521446315;15359;15389.69220615587;14395.78406323906;14402.423903043866;14486.637834054154;14602.415903363853;14645.121292722444;777.8910952466659;929.1823195587873;952.2144231009411;964.8456247000481;967.4243824924159;967.5500892085179;970.8883478400004;972.6352617768337;977.968243503104;978.6574698855414;1016.6695823857239;1028.090140225898;1031.4997226345217;1032.1072272484323;1037.8858325584179;1014.06705830636;1017.2269075502671;1021.4331046269317;1023.5138309303096;1024.0834453164414;747.9887801682979;756.3004221095465;767.9747537038061;771.4252881603186;774.8372841703249;15156.31796569146;15160.241987900672;15189.772153417707;15189.848101519065;15198;11397.259178153394;12813.295268760308;12835.294058826761;13092.952563794874;13094.410751516109;8096.959515202387;9595.376300540442;9734.36726612768;9754.561044753003;9758.170555502791;3459.5848498180126;3498.667626575497;3549.467579863041;3599.0102721751728;3619.49327094207;80118.98512685914;81491.5925420375;82025;82312.58843705803;82600.17399825985;7031;9109.99790023097;9251.44491330509;9256.814863702688;9302.488363139957;20463.8976805115;20552.794472055088;20563.794362056487;20723.585528289652;20736.792632073786;6722.462203023844;7133.964330178316;7271.709131634675;7355.926440735631;7389.81525461857;3846.769193848378;3879.228737980159;3987.4616926715103;4019.738716983387;4024.9798751006056;3004.8798048077833;3536.504889315498;3547.9822600887346;3562.3943929532043;3608.1160115771804;643.1799455694028;644.432899048834;655.5837043477426;656.4256275758711;659.1003280522053;546.4126064480699;570.4010788671878;593.0836857055859;599.7211296746947;600.0459269761101;6944.652767361713;7972.123066462685;8147.470414423044;8170.754877353689;8265.504069755834;553.2586334312041;592.141394977276;608.8599622086945;623.4700504571169;632.8418993242356;3558.7508874379064;3580.98209508956;3780.4896338993885;3813.904652383713;3859.980700096538;86760;89122;90179.64730529048;99273.50363248137;99810;76391.85412218822;76808;77199.2280077192;77674;78498;68050;68352.97470537847;68672.4159480065;68689.65655171692;70002;8446.408751387344;8446.577671116542;8558.700445484377;8583.18459746323;8669.263112635497;48334.27498587454;49112.263316051;49204.75397622989;49234.75382623064;49513;55904.72047639736;66072.66963665343;67208;67322.66338668275;67599.3240067593;10754.677359679223;10814.675559733221;10898.182636302468;11043.392613406018;11249.606263780728;11727.648170554898;11965.16243862956;12018.75962480763;12035.819462708241;12322.75354492923;11430.71423214393;11642.185047046625;11670.70823229426;11731.589394371156;11763.235389699643;9433.669821556212;10772.892271077502;11298.4915678793;11334.773304534028;11424;11090.500927458123;11119.499622517167;11157.66527004191;11439.828402574134;11809.23239989398;9503.239740820856;9613.311506827471;9632.422054676741;9710.514474276117;9901.702948911545;7198.8920166198595;8075.651157446695;9378.390404623678;9381.827271591052;9812.65655702047 14:40:59 INFO - PROCESS | 2288 | __end_tp_report 14:40:59 INFO - PROCESS | 2288 | __start_cc_report 14:40:59 INFO - PROCESS | 2288 | _x_x_mozilla_cycle_collect,362 14:40:59 INFO - PROCESS | 2288 | __end_cc_report 14:40:59 INFO - PROCESS | 2288 | __startTimestamp1458164459792__endTimestamp 14:40:59 INFO - PROCESS | 2288 | 14:40:59 INFO - PROCESS | 2288 | ------- Summary: start ------- 14:40:59 INFO - PROCESS | 2288 | Number of tests: 6 14:40:59 INFO - PROCESS | 2288 | 14:40:59 INFO - PROCESS | 2288 | [#0] dojo.html Cycles:165 Average:5685.76 Median:5951.02 stddev:788.33 (13.2%) stddev-sans-first:764.57 14:40:59 INFO - PROCESS | 2288 | Values: 3117.6 3477.1 3501.8 3511.4 3567.4 5724.1 5769.2 5778.0 5782.1 5808.0 5540.3 5806.1 5874.2 5878.8 5911.9 5118.1 5161.7 5225.8 5241.7 5273.5 33.7 5226.9 5237.2 5334.9 5411.3 5142.8 5221.8 5229.2 5245.7 5273.3 4418.4 5271.8 5278.3 5279.2 5332.9 5023.5 5169.6 5202.1 5251.6 5272.0 5472.5 5581.9 5623.7 5667.5 5680.0 6149.5 6203.0 6203.1 6207.5 6212.6 5125.7 6156.0 6191.9 6206.1 6242.4 5403.6 5896.2 5899.9 5918.4 5923.3 6028.2 6284.8 6295.6 6302.0 6340.3 5249.0 6018.3 6123.6 6196.1 6196.5 6169.2 6224.8 6241.4 6253.2 6259.1 6115.6 6216.9 6226.9 6258.8 6281.9 6145.4 6220.7 6257.9 6270.3 6278.7 4180.8 4658.9 4886.4 4936.2 4953.1 4319.6 4382.9 4436.4 4459.0 4470.9 5623.8 5766.8 5808.2 5928.7 5959.3 5678.4 5870.1 6187.5 6201.9 6214.5 5727.1 5880.7 5893.4 5894.9 5917.3 4104.5 5351.5 5352.3 5401.1 5462.3 5877.6 6310.2 6327.7 6332.9 6340.9 6116.3 6125.3 6202.7 6210.1 6210.1 6316.1 6395.9 6419.5 6424.3 6428.0 6094.6 6097.7 6100.4 6112.1 6113.3 6063.1 6123.5 6135.6 6137.5 6141.4 6013.2 6053.2 6069.2 6085.8 6104.8 5933.7 6064.1 6088.1 6126.1 6145.5 5805.9 5995.7 6027.4 6037.6 6053.9 6004.9 6142.7 6150.0 6150.4 6156.8 5540.4 5951.0 6009.6 6010.9 6017.6 14:40:59 INFO - PROCESS | 2288 | 14:40:59 INFO - PROCESS | 2288 | [#1] ext.html Cycles:180 Average:65044.53 Median:38935.82 stddev:137462.40 (353.0%) stddev-sans-first:137762.48 14:40:59 INFO - PROCESS | 2288 | Values: 458.2 483.2 581.5 595.3 652.3 37971.4 38619.0 38821.8 38851.8 38964.6 34300.7 40152.0 40183.8 40339.0 40427.0 9495.0 9665.5 9710.8 9716.7 9733.1 9461.5 9712.8 9723.9 9781.2 9781.8 9718.8 9760.2 9787.6 9838.0 9841.6 9684.5 9751.2 9779.4 9785.6 9809.4 8317.5 8913.9 9733.5 9779.0 9791.4 31962.7 39293.4 39449.6 39465.6 39575.6 3113.7 3216.0 3232.6 3366.7 3518.0 23116.8 27214.6 28302.3 28517.7 28562.0 2720.7 2786.5 2798.8 2799.1 2913.0 440848.0 446507.0 449984.0 451631.0 454718.0 45643.0 63116.7 63404.7 63408.7 63598.7 42487.8 45811.1 46067.8 46173.8 46448.0 15926.4 16106.0 16163.8 16194.6 16204.8 12926.8 12939.7 12941.0 12949.5 13006.3 14643.5 14761.6 14826.5 14830.5 14831.4 5269.6 5551.8 6430.5 6548.9 6556.5 916.3 1062.0 1086.0 1108.0 1144.9 25307.2 30060.5 30260.4 30325.4 30406.4 1098.9 1107.5 1122.0 1132.2 1166.6 13006.7 15217.2 15269.7 15519.1 15640.1 561112.0 564381.0 570682.0 570761.0 571108.0 60417.0 60625.7 60911.7 61086.7 61189.0 1390.3 1441.1 1469.0 1474.9 1482.9 29502.6 29614.0 29664.0 30285.8 30305.4 51058.7 51466.0 51607.2 51908.0 51922.2 520121.0 523343.0 524579.8 526596.4 527214.0 34289.3 34772.0 43600.0 44910.3 46345.3 45734.5 46046.8 46359.8 46711.3 46809.5 37216.6 37991.7 38128.8 38265.2 38907.0 37399.1 37583.4 37645.2 38082.2 38571.4 34291.3 37999.6 38342.0 38730.6 39112.2 30916.2 32104.0 32226.4 32320.7 32375.0 24273.0 24779.9 24799.0 25726.2 26113.5 14:40:59 INFO - PROCESS | 2288 | 14:40:59 INFO - PROCESS | 2288 | [#2] jquery.html Cycles:180 Average:36229.51 Median:21570.39 stddev:108832.57 (504.5%) stddev-sans-first:109104.47 14:40:59 INFO - PROCESS | 2288 | Values: 319.2 338.7 372.2 376.8 379.6 19890.2 20381.8 20821.4 21258.0 21296.1 20193.5 20384.6 20577.9 21402.5 21441.6 5639.8 5820.8 5971.5 6018.2 6023.7 4266.8 5545.3 6345.7 6640.4 6646.3 6507.6 6561.4 6579.4 6582.7 6584.9 6295.0 6458.5 6516.5 6525.2 6579.7 5503.7 5525.8 5570.8 5580.1 5584.9 26046.9 26225.7 26245.3 26554.9 26639.3 2125.2 2127.5 2149.2 2304.2 2900.2 9381.7 9642.2 9812.0 14939.9 15525.9 1768.3 1788.8 1826.2 1833.8 1876.5 104926.0 110520.0 111049.4 112001.0 115064.0 11133.3 11207.2 11208.5 11365.7 11412.7 13643.5 13679.4 13686.0 13703.1 13733.2 6987.8 8662.7 8705.9 8742.4 8828.0 8826.8 8890.7 8937.5 8980.4 8999.4 4394.8 4485.7 4494.5 4518.2 4530.1 1621.5 1708.8 1758.6 1896.9 1910.1 968.5 988.6 1033.8 1053.2 1068.9 19606.4 20857.2 21475.0 21503.8 21637.0 965.9 1010.7 1013.7 1016.7 1070.7 10821.9 11129.9 11224.7 11255.2 11255.9 574712.0 667095.0 673286.0 676074.0 686629.0 120191.2 120857.8 121588.0 123982.0 124578.4 1062.3 1070.0 1079.0 1079.4 1099.1 18919.7 19015.0 19091.1 19237.9 19250.3 52126.0 52554.0 52854.0 53023.4 54361.5 74595.0 75471.0 75782.5 77459.5 77679.6 7702.9 7853.8 7882.0 7932.7 7942.0 11027.6 12603.9 12832.1 12841.2 12946.6 10400.8 10736.1 10741.5 10947.7 11102.7 10196.5 10687.7 10805.1 10980.9 11000.2 10974.9 11216.9 11264.1 11342.3 11448.8 7822.9 7845.4 7880.1 7979.7 8095.5 7604.8 7849.0 8070.4 8359.4 8395.7 14:40:59 INFO - PROCESS | 2288 | 14:40:59 INFO - PROCESS | 2288 | [#3] mootools.html Cycles:180 Average:5898.84 Median:5439.82 stddev:3046.23 (56.0%) stddev-sans-first:3037.51 14:40:59 INFO - PROCESS | 2288 | Values: 1585.1 1602.2 1907.6 1978.8 1991.9 7660.7 8365.5 8449.2 8621.0 8635.3 8445.3 8459.1 8543.9 8565.3 8566.7 2474.0 2487.8 2492.5 2498.4 2510.4 2135.6 2426.9 2483.0 2492.8 2497.4 2463.7 2471.8 2477.1 2499.5 2501.0 2464.8 2471.9 2489.9 2492.3 2492.4 2453.1 2476.3 2483.1 2486.4 2492.1 8588.2 8588.4 8617.9 8636.2 8719.4 5253.7 5350.4 5380.7 5403.1 5435.6 3288.4 3530.3 3636.3 3677.0 3701.4 1066.5 1078.0 1085.9 1086.3 1086.3 9757.0 11278.7 11280.5 11363.8 11410.8 4494.3 4526.1 4780.1 4835.5 4886.4 9857.0 9857.9 9885.8 9896.0 9905.0 5410.4 5422.3 5434.6 5444.1 5467.0 4333.8 4770.3 4866.1 4869.2 4945.2 3829.5 3908.6 3922.7 3941.9 3965.6 1311.4 1319.3 1322.4 1325.2 1340.7 1186.8 1364.7 1398.8 1409.6 1415.9 7921.6 7926.6 7946.5 7961.4 7968.9 507.1 519.4 524.5 524.9 526.2 6079.3 6157.5 6157.9 6214.6 6224.2 10127.3 10339.9 10435.7 10475.8 10514.0 9712.2 10229.1 10252.4 10284.5 10317.4 7938.0 8065.8 8074.6 8148.7 8152.0 7843.8 7868.1 7925.2 7933.4 7958.3 7562.6 8941.9 9133.5 9167.7 9293.6 9218.6 9477.1 9504.7 9627.2 9676.0 6623.1 7099.9 7303.8 7357.8 7518.6 7425.8 7702.7 8119.2 8157.1 8160.0 7203.4 7298.4 7315.0 7417.6 7445.1 6942.8 7048.1 7064.9 7158.5 7231.6 7461.2 7489.1 7533.8 7548.7 7567.4 6811.3 6852.0 6855.0 6873.9 6893.7 6828.7 6938.5 6950.3 6966.3 7026.5 14:40:59 INFO - PROCESS | 2288 | 14:40:59 INFO - PROCESS | 2288 | [#4] prototype.html Cycles:180 Average:5935.34 Median:6861.62 stddev:1938.34 (28.2%) stddev-sans-first:1897.32 14:40:59 INFO - PROCESS | 2288 | Values: 315.1 337.0 337.1 340.9 342.3 6845.8 6965.2 6970.2 6994.5 7013.3 6908.3 6913.9 6915.0 6921.0 6925.8 4791.6 4899.4 5046.6 5102.6 5114.9 5044.1 5073.2 5097.1 5133.4 5145.3 4073.0 5048.0 5081.1 5101.5 5103.2 4135.6 5071.4 5072.7 5077.1 5077.1 4340.9 4353.5 4360.6 4363.9 4369.7 6023.4 6051.6 6312.3 6696.3 6704.8 5798.9 5847.9 5849.0 5856.9 5870.7 5959.5 5993.6 7304.6 7352.9 7374.0 4665.0 4670.7 4673.2 4675.2 4676.7 7374.4 7726.4 7815.0 7839.2 7850.7 4487.0 4624.9 4720.1 4723.2 4723.9 4831.8 4838.7 4841.2 4841.8 4870.5 4812.2 5807.2 5819.6 5829.2 5838.4 7380.2 7396.7 7397.6 7412.4 7446.0 1660.5 1686.0 1686.5 1689.7 1695.5 1036.4 1077.0 1077.4 1082.7 1087.0 6917.3 6921.7 6935.4 6949.5 6951.6 5448.4 6182.8 7618.8 7652.9 7654.7 6871.6 6878.6 6879.1 6885.7 6890.7 3225.0 3231.5 4057.3 4064.7 4074.6 5904.3 7873.5 7887.6 8037.6 8041.6 6783.1 7826.9 7892.4 8010.8 8045.7 6518.9 6924.5 8129.7 8140.7 8143.3 7432.9 7699.3 7724.5 7741.0 7752.3 7532.2 7556.7 7565.4 7572.3 7585.0 6955.4 8104.4 8105.8 8109.0 8113.6 3947.4 4627.5 4740.2 4756.8 4760.0 6464.9 7196.3 7274.5 7678.4 7708.4 6575.0 6851.7 7388.2 7404.9 7416.0 7389.9 7406.7 7411.3 7415.7 7417.5 7171.2 7177.0 7185.4 7196.6 7218.8 7191.3 7411.5 7422.2 7438.3 7447.0 7177.8 7230.4 7234.7 7256.1 7262.5 14:40:59 INFO - PROCESS | 2288 | 14:40:59 INFO - PROCESS | 2288 | [#5] yui.html Cycles:180 Average:18109.46 Median:599.88 stddev:25556.99 (4260.3%) stddev-sans-first:25595.34 14:40:59 INFO - PROCESS | 2288 | Values: 722.0 758.8 767.3 783.7 801.8 15116.8 15242.1 15354.2 15359.0 15389.7 14395.8 14402.4 14486.6 14602.4 14645.1 777.9 929.2 952.2 964.8 967.4 967.6 970.9 972.6 978.0 978.7 1016.7 1028.1 1031.5 1032.1 1037.9 1014.1 1017.2 1021.4 1023.5 1024.1 748.0 756.3 768.0 771.4 774.8 15156.3 15160.2 15189.8 15189.8 15198.0 11397.3 12813.3 12835.3 13093.0 13094.4 8097.0 9595.4 9734.4 9754.6 9758.2 3459.6 3498.7 3549.5 3599.0 3619.5 80119.0 81491.6 82025.0 82312.6 82600.2 7031.0 9110.0 9251.4 9256.8 9302.5 20463.9 20552.8 20563.8 20723.6 20736.8 6722.5 7134.0 7271.7 7355.9 7389.8 3846.8 3879.2 3987.5 4019.7 4025.0 3004.9 3536.5 3548.0 3562.4 3608.1 643.2 644.4 655.6 656.4 659.1 546.4 570.4 593.1 599.7 600.0 6944.7 7972.1 8147.5 8170.8 8265.5 553.3 592.1 608.9 623.5 632.8 3558.8 3581.0 3780.5 3813.9 3860.0 86760.0 89122.0 90179.6 99273.5 99810.0 76391.9 76808.0 77199.2 77674.0 78498.0 68050.0 68353.0 68672.4 68689.7 70002.0 8446.4 8446.6 8558.7 8583.2 8669.3 48334.3 49112.3 49204.8 49234.8 49513.0 55904.7 66072.7 67208.0 67322.7 67599.3 10754.7 10814.7 10898.2 11043.4 11249.6 11727.6 11965.2 12018.8 12035.8 12322.8 11430.7 11642.2 11670.7 11731.6 11763.2 9433.7 10772.9 11298.5 11334.8 11424.0 11090.5 11119.5 11157.7 11439.8 11809.2 9503.2 9613.3 9632.4 9710.5 9901.7 7198.9 8075.7 9378.4 9381.8 9812.7 14:40:59 INFO - PROCESS | 2288 | -------- Summary: end -------- 14:40:59 INFO - PROCESS | 2288 | 14:41:00 INFO - TEST-INFO | 2288: exit 0 14:41:00 INFO - TEST-OK | dromaeo_css | took 1109745ms 14:41:00 INFO - TEST-START | kraken 14:41:00 INFO - operating with platform_type : mac_ 14:41:00 INFO - Initialising browser for kraken test... 14:41:00 INFO - TEST-INFO | started process 2294 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpSj6G3N/profile http://localhost:50049/getInfo.html) 14:41:02 INFO - PROCESS | 2294 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 14:41:03 INFO - PROCESS | 2294 | __metrics Screen width/height:1600/1200 14:41:03 INFO - PROCESS | 2294 | colorDepth:24 14:41:03 INFO - PROCESS | 2294 | Browser inner width/height: 1024/689 14:41:03 INFO - PROCESS | 2294 | __metrics 14:41:03 ERROR - PROCESS | 2294 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 14:41:03 INFO - TEST-INFO | 2294: exit 0 14:41:03 INFO - Browser initialized. 14:41:03 INFO - Running cycle 1/1 for kraken test... 14:41:03 INFO - TEST-INFO | started process 2297 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpSj6G3N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:41:15 INFO - PROCESS | 2297 | RSS: Main: 256712704 14:41:15 INFO - PROCESS | 2297 | 14:41:18 INFO - PROCESS | 2297 | Cycle 1(1): loaded http://localhost:50049/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50049/tests/kraken/driver.html?testName=audio-beat-detection) 14:41:19 INFO - PROCESS | 2297 | RSS: Main: 269406208 14:41:19 INFO - PROCESS | 2297 | 14:41:22 INFO - PROCESS | 2297 | Cycle 1(1): loaded http://localhost:50049/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50049/tests/kraken/driver.html?testName=audio-dft) 14:41:22 INFO - PROCESS | 2297 | RSS: Main: 277065728 14:41:22 INFO - PROCESS | 2297 | 14:41:26 INFO - PROCESS | 2297 | Cycle 1(1): loaded http://localhost:50049/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50049/tests/kraken/driver.html?testName=audio-fft) 14:41:26 INFO - PROCESS | 2297 | RSS: Main: 280064000 14:41:26 INFO - PROCESS | 2297 | 14:41:28 INFO - PROCESS | 2297 | Cycle 1(1): loaded http://localhost:50049/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50049/tests/kraken/driver.html?testName=audio-oscillator) 14:41:29 INFO - PROCESS | 2297 | RSS: Main: 281968640 14:41:29 INFO - PROCESS | 2297 | 14:41:31 INFO - PROCESS | 2297 | Cycle 1(1): loaded http://localhost:50049/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50049/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:41:32 INFO - PROCESS | 2297 | RSS: Main: 283291648 14:41:32 INFO - PROCESS | 2297 | 14:41:34 INFO - PROCESS | 2297 | Cycle 1(1): loaded http://localhost:50049/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50049/tests/kraken/driver.html?testName=imaging-darkroom) 14:41:35 INFO - PROCESS | 2297 | RSS: Main: 284413952 14:41:35 INFO - PROCESS | 2297 | 14:41:38 INFO - PROCESS | 2297 | Cycle 1(1): loaded http://localhost:50049/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50049/tests/kraken/driver.html?testName=imaging-desaturate) 14:41:38 INFO - PROCESS | 2297 | RSS: Main: 284336128 14:41:38 INFO - PROCESS | 2297 | 14:41:41 INFO - PROCESS | 2297 | Cycle 1(1): loaded http://localhost:50049/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50049/tests/kraken/driver.html?testName=json-parse-financial) 14:41:42 INFO - PROCESS | 2297 | RSS: Main: 284663808 14:41:42 INFO - PROCESS | 2297 | 14:41:43 INFO - PROCESS | 2297 | Cycle 1(1): loaded http://localhost:50049/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50049/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:41:44 INFO - PROCESS | 2297 | RSS: Main: 285061120 14:41:44 INFO - PROCESS | 2297 | 14:41:46 INFO - PROCESS | 2297 | Cycle 1(1): loaded http://localhost:50049/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50049/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:41:47 INFO - PROCESS | 2297 | RSS: Main: 282955776 14:41:47 INFO - PROCESS | 2297 | 14:41:49 INFO - PROCESS | 2297 | Cycle 1(1): loaded http://localhost:50049/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50049/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:41:49 INFO - PROCESS | 2297 | RSS: Main: 283340800 14:41:49 INFO - PROCESS | 2297 | 14:41:52 INFO - PROCESS | 2297 | Cycle 1(1): loaded http://localhost:50049/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50049/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:41:53 INFO - PROCESS | 2297 | RSS: Main: 285536256 14:41:53 INFO - PROCESS | 2297 | 14:41:55 INFO - PROCESS | 2297 | Cycle 1(1): loaded http://localhost:50049/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50049/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:41:56 INFO - PROCESS | 2297 | RSS: Main: 285810688 14:41:56 INFO - PROCESS | 2297 | 14:41:58 INFO - PROCESS | 2297 | Cycle 1(1): loaded http://localhost:50049/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50049/tests/kraken/driver.html?testName=ai-astar) 14:41:58 INFO - PROCESS | 2297 | RSS: Main: 286076928 14:41:58 INFO - PROCESS | 2297 | 14:41:58 INFO - PROCESS | 2297 | __start_tp_report 14:41:58 INFO - PROCESS | 2297 | _x_x_mozilla_page_load 14:41:58 INFO - PROCESS | 2297 | _x_x_mozilla_page_load_details 14:41:58 INFO - PROCESS | 2297 | |i|pagename|runs| 14:41:58 INFO - PROCESS | 2297 | |0;ai-astar;113;108;95;166;167;183;114;114;115;114 14:41:58 INFO - PROCESS | 2297 | |1;audio-beat-detection;191;112;187;185;154;170;152;119;158;122 14:41:58 INFO - PROCESS | 2297 | |2;audio-dft;191;195;195;244;264;234;215;175;264;274 14:41:58 INFO - PROCESS | 2297 | |3;audio-fft;74;67;69;152;80;60;56;59;126;57 14:41:58 INFO - PROCESS | 2297 | |4;audio-oscillator;87;86;123;79;81;81;124;79;78;122 14:41:58 INFO - PROCESS | 2297 | |5;imaging-gaussian-blur;88;85;79;129;134;86;91;86;87;86 14:41:58 INFO - PROCESS | 2297 | |6;imaging-darkroom;94;93;95;93;94;94;93;94;96;120 14:41:58 INFO - PROCESS | 2297 | |7;imaging-desaturate;98;153;91;91;98;92;92;91;90;140 14:41:58 INFO - PROCESS | 2297 | |8;json-parse-financial;54;57;54;57;57;56;55;65;57;52 14:41:58 INFO - PROCESS | 2297 | |9;json-stringify-tinderbox;66;68;74;73;80;73;70;69;66;65 14:41:58 INFO - PROCESS | 2297 | |10;stanford-crypto-aes;76;105;111;83;83;85;85;85;84;85 14:41:58 INFO - PROCESS | 2297 | |11;stanford-crypto-ccm;125;126;132;138;141;125;126;132;129;131 14:41:58 INFO - PROCESS | 2297 | |12;stanford-crypto-pbkdf2;129;141;142;127;162;181;183;140;141;143 14:41:58 INFO - PROCESS | 2297 | |13;stanford-crypto-sha256-iterative;70;69;69;67;69;68;89;95;97;79 14:41:58 INFO - PROCESS | 2297 | __end_tp_report 14:41:58 INFO - PROCESS | 2297 | __start_cc_report 14:41:58 INFO - PROCESS | 2297 | _x_x_mozilla_cycle_collect,925 14:41:58 INFO - PROCESS | 2297 | __end_cc_report 14:41:58 INFO - PROCESS | 2297 | __startTimestamp1458164518261__endTimestamp 14:41:58 INFO - PROCESS | 2297 | 14:41:58 INFO - PROCESS | 2297 | ------- Summary: start ------- 14:41:58 INFO - PROCESS | 2297 | Number of tests: 14 14:41:58 INFO - PROCESS | 2297 | 14:41:58 INFO - PROCESS | 2297 | [#0] ai-astar Cycles:10 Average:128.90 Median:140.50 stddev:30.65 (21.8%) stddev-sans-first:31.96 14:41:58 INFO - PROCESS | 2297 | Values: 113.0 108.0 95.0 166.0 167.0 183.0 114.0 114.0 115.0 114.0 14:41:58 INFO - PROCESS | 2297 | 14:41:58 INFO - PROCESS | 2297 | [#1] audio-beat-detection Cycles:10 Average:155.00 Median:164.00 stddev:29.25 (17.8%) stddev-sans-first:27.97 14:41:58 INFO - PROCESS | 2297 | Values: 191.0 112.0 187.0 185.0 154.0 170.0 152.0 119.0 158.0 122.0 14:41:58 INFO - PROCESS | 2297 | 14:41:58 INFO - PROCESS | 2297 | [#2] audio-dft Cycles:10 Average:225.10 Median:239.00 stddev:35.65 (14.9%) stddev-sans-first:35.62 14:41:58 INFO - PROCESS | 2297 | Values: 191.0 195.0 195.0 244.0 264.0 234.0 215.0 175.0 264.0 274.0 14:41:58 INFO - PROCESS | 2297 | 14:41:58 INFO - PROCESS | 2297 | [#3] audio-fft Cycles:10 Average:80.00 Median:63.50 stddev:32.61 (51.4%) stddev-sans-first:34.52 14:41:58 INFO - PROCESS | 2297 | Values: 74.0 67.0 69.0 152.0 80.0 60.0 56.0 59.0 126.0 57.0 14:41:58 INFO - PROCESS | 2297 | 14:41:58 INFO - PROCESS | 2297 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:80.00 stddev:20.23 (25.3%) stddev-sans-first:21.29 14:41:58 INFO - PROCESS | 2297 | Values: 87.0 86.0 123.0 79.0 81.0 81.0 124.0 79.0 78.0 122.0 14:41:58 INFO - PROCESS | 2297 | 14:41:58 INFO - PROCESS | 2297 | [#5] imaging-gaussian-blur Cycles:10 Average:95.10 Median:86.00 stddev:19.45 (22.6%) stddev-sans-first:20.46 14:41:58 INFO - PROCESS | 2297 | Values: 88.0 85.0 79.0 129.0 134.0 86.0 91.0 86.0 87.0 86.0 14:41:58 INFO - PROCESS | 2297 | 14:41:58 INFO - PROCESS | 2297 | [#6] imaging-darkroom Cycles:10 Average:96.60 Median:94.00 stddev:8.28 (8.8%) stddev-sans-first:8.72 14:41:58 INFO - PROCESS | 2297 | Values: 94.0 93.0 95.0 93.0 94.0 94.0 93.0 94.0 96.0 120.0 14:41:58 INFO - PROCESS | 2297 | 14:41:58 INFO - PROCESS | 2297 | [#7] imaging-desaturate Cycles:10 Average:103.60 Median:91.50 stddev:22.99 (25.1%) stddev-sans-first:24.30 14:41:58 INFO - PROCESS | 2297 | Values: 98.0 153.0 91.0 91.0 98.0 92.0 92.0 91.0 90.0 140.0 14:41:58 INFO - PROCESS | 2297 | 14:41:58 INFO - PROCESS | 2297 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:57.00 stddev:3.47 (6.1%) stddev-sans-first:3.57 14:41:58 INFO - PROCESS | 2297 | Values: 54.0 57.0 54.0 57.0 57.0 56.0 55.0 65.0 57.0 52.0 14:41:58 INFO - PROCESS | 2297 | 14:41:58 INFO - PROCESS | 2297 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:71.50 stddev:4.65 (6.5%) stddev-sans-first:4.65 14:41:58 INFO - PROCESS | 2297 | Values: 66.0 68.0 74.0 73.0 80.0 73.0 70.0 69.0 66.0 65.0 14:41:58 INFO - PROCESS | 2297 | 14:41:58 INFO - PROCESS | 2297 | [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:84.50 stddev:10.87 (12.9%) stddev-sans-first:10.60 14:41:58 INFO - PROCESS | 2297 | Values: 76.0 105.0 111.0 83.0 83.0 85.0 85.0 85.0 84.0 85.0 14:41:58 INFO - PROCESS | 2297 | 14:41:58 INFO - PROCESS | 2297 | [#11] stanford-crypto-ccm Cycles:10 Average:130.50 Median:131.50 stddev:5.52 (4.2%) stddev-sans-first:5.49 14:41:58 INFO - PROCESS | 2297 | Values: 125.0 126.0 132.0 138.0 141.0 125.0 126.0 132.0 129.0 131.0 14:41:58 INFO - PROCESS | 2297 | 14:41:58 INFO - PROCESS | 2297 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.90 Median:142.50 stddev:19.80 (13.9%) stddev-sans-first:19.64 14:41:58 INFO - PROCESS | 2297 | Values: 129.0 141.0 142.0 127.0 162.0 181.0 183.0 140.0 141.0 143.0 14:41:58 INFO - PROCESS | 2297 | 14:41:58 INFO - PROCESS | 2297 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.20 Median:74.50 stddev:11.99 (16.1%) stddev-sans-first:12.43 14:41:58 INFO - PROCESS | 2297 | Values: 70.0 69.0 69.0 67.0 69.0 68.0 89.0 95.0 97.0 79.0 14:41:58 INFO - PROCESS | 2297 | -------- Summary: end -------- 14:41:58 INFO - PROCESS | 2297 | 14:41:59 INFO - TEST-INFO | 2297: exit 0 14:41:59 INFO - TEST-OK | kraken | took 58796ms 14:41:59 INFO - SUITE-END | took 1168s 14:41:59 INFO - Completed test suite (00:19:28) 14:41:59 INFO - javascript benchmark 14:41:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3117.5791268178796, 3477.095955051686, 3501.842417091231, 3511.420615598425, 3567.429211326188, 5724.141378793178, 5769.221155144054, 5777.971110144454, 5782.103773915044, 5808.012637851565, 5540.252065971093, 5806.071028635419, 5874.206982057421, 5878.823635290948, 5911.85220369491, 5118.07874582575, 5161.690298582078, 5225.843224703265, 5241.659292146017, 5273.525382715555, 33.67541742981462, 5226.947730522703, 5237.162054071349, 5334.919976200341, 5411.323584551931, 5142.820001299955, 5221.765020574065, 5229.1633338666015, 5245.6852588844795, 5273.2617433559335, 4418.381426600278, 5271.841844744664, 5278.264472298352, 5279.1817268323475, 5332.946670533283, 5023.547880690755, 5169.586433085344, 5202.141646628302, 5251.632385733, 5271.998320319127, 5472.50747432729, 5581.916271255935, 5623.690697011662, 5667.489925906688, 5680.005998950209, 6149.477294429978, 6203.038529028008, 6203.131561581382, 6207.4723648489935, 6212.627242365473, 5125.666831655931, 6156.0, 6191.938080619181, 6206.069089636546, 6242.438180563771, 5403.648762830403, 5896.204012458306, 5899.882002359972, 5918.437748413937, 5923.259592550931, 6028.216331876915, 6284.842878928063, 6295.559310848196, 6302.023186406114, 6340.270868850049, 5249.028929648028, 6018.337982821886, 6123.571350005457, 6196.10156527301, 6196.504279657616, 6169.2288463942, 6224.844378890564, 6241.407066328691, 6253.155823963798, 6259.123722678829, 6115.602485838406, 6216.875662486816, 6226.906596401058, 6258.780942666985, 6281.937180628135, 6145.432914606747, 6220.657863817533, 6257.937420625826, 6270.278917924497, 6278.748850046039, 4180.790960452026, 4658.930116048195, 4886.438059623118, 4936.234883593049, 4953.108440480748, 4319.589638984291, 4382.890427739332, 4436.401085853433, 4459.0, 4470.932936005963, 5623.803166889221, 5766.826995190151, 5808.215890854765, 5928.703564821828, 5959.255093113361, 5678.4037676044245, 5870.14882841994, 6187.474064704551, 6201.929555743067, 6214.471769899609, 5727.083666613322, 5880.7353669085, 5893.44012318829, 5894.852628684317, 5917.260342457193, 4104.4664193654635, 5351.491608297206, 5352.2506849041165, 5401.135818269058, 5462.344518657707, 5877.617954832922, 6310.1796766420075, 6327.715252813635, 6332.873342533124, 6340.904886426707, 6116.305337586134, 6125.296497837281, 6202.658853762906, 6210.068489726577, 6210.130581718473, 6316.11574379578, 6395.93604063972, 6419.518536109717, 6424.2933277338525, 6428.035794630843, 6094.634321940698, 6097.664628445478, 6100.420460056465, 6112.083187521907, 6113.266408031065, 6063.120847477179, 6123.540734445023, 6135.631862088289, 6137.539684523589, 6141.447269745744, 6013.188219590299, 6053.182820319376, 6069.238496484001, 6085.756569737338, 6104.816855494342, 5933.673647949404, 6064.120702498201, 6088.056351265561, 6126.142340072304, 6145.508359331154, 5805.896879592864, 5995.700214989321, 6027.397260273938, 6037.637741735334, 6053.939460605337, 6004.87990240184, 6142.723577438936, 6150.04674275488, 6150.354212807591, 6156.846078848064, 5540.36285827135, 5951.018082016419, 6009.639421634716, 6010.909836352545, 6017.638941663514], "unit": "score", "name": "dojo.html", "value": 5639.304851436803}, {"lowerIsBetter": false, "replicates": [458.16842430987754, 483.15447966059395, 581.4592429040993, 595.2797115490257, 652.3411354531922, 37971.430428543594, 38619.0, 38821.80589097054, 38851.80574097126, 38964.61035389645, 34300.65699343006, 40152.0, 40183.79448616539, 40338.99152521188, 40427.0, 9495.0, 9665.46839923804, 9710.805783884318, 9716.65991690291, 9733.075357840993, 9461.526923653824, 9712.805743885117, 9723.854142187873, 9781.168600668952, 9781.804363912717, 9718.757031074245, 9760.219182465386, 9787.608495660164, 9838.016198380175, 9841.606335746561, 9684.515774211297, 9751.21990240779, 9779.364341317792, 9785.559649815776, 9809.362391444532, 8317.542535160565, 8913.910860891438, 9733.513324333755, 9778.951105244429, 9791.412515249036, 31962.680373196203, 39293.41059884104, 39449.60550394488, 39465.605343946765, 39575.60424395748, 3113.692249255318, 3215.9678403216135, 3232.612086549629, 3366.7306615470948, 3518.032541051206, 23116.76883231163, 27214.591781123298, 28302.292442688893, 28517.714822851714, 28562.0, 2720.7007229204773, 2786.456640955015, 2798.790090743202, 2799.1322689966178, 2912.956305655417, 440848.0, 446507.0, 449983.99999999674, 451631.0, 454718.0, 45643.0, 63116.68441657762, 63404.68297658575, 63408.68295658492, 63598.728025440156, 42487.787561062614, 45811.083778324246, 46067.84830379267, 46173.769131154804, 46448.0, 15926.442574509836, 16106.0, 16163.838361616468, 16194.59513512148, 16204.75692864608, 12926.806097908539, 12939.676508087374, 12941.0, 12949.54676586315, 13006.349682515836, 14643.48747793822, 14761.630959225891, 14826.481073162387, 14830.480933167288, 14831.406743730346, 5269.631125821233, 5551.833444996657, 6430.453411460078, 6548.886689262837, 6556.475481961432, 916.326500022483, 1061.984070238947, 1085.9701581351042, 1107.9667609971714, 1144.8969592736694, 25307.240782776178, 30060.54909176364, 30260.394792104475, 30325.393492130035, 30406.391872162432, 1098.8516550265772, 1107.534835369147, 1121.971950701239, 1132.1621999720312, 1166.6266794625637, 13006.739865202642, 15217.239138043053, 15269.694606108038, 15519.068855868683, 15640.139792311533, 561112.0, 564381.0, 570682.0, 570761.0, 571108.0, 60417.0, 60625.69687151536, 60911.69544152251, 61086.69456652688, 61189.0, 1390.3395886953615, 1441.099312929419, 1469.0304399096544, 1474.852514748538, 1482.8665420112027, 29502.55746163766, 29614.0, 29664.034680291377, 30285.848570757003, 30305.393892122476, 51058.74470627623, 51465.97068058543, 51607.225891610906, 51908.0, 51922.22116668329, 520121.0, 523343.0, 524579.7542024531, 526596.3670181625, 527214.0, 34289.31421371608, 34772.0, 43600.0, 44910.3263451055, 46345.304820427045, 45734.54265457436, 46046.7697661523, 46359.768201158775, 46711.29933050939, 46809.531904680516, 37216.6278337224, 37991.67029153966, 38128.809355953046, 38265.23469530649, 38907.02732431598, 37399.065023374635, 37583.40955779844, 37645.24709505849, 38082.2383552333, 38571.421428679154, 34291.31417371589, 37999.62000379961, 38342.041448964, 38730.6126938727, 39112.217755645295, 30916.22709432282, 32104.0, 32226.35547289088, 32320.676793232706, 32375.0, 24273.029078836647, 24779.88490517895, 24799.00803967821, 25726.228213153634, 26113.474680917832], "unit": "score", "name": "ext.html", "value": 19479.60504138174}, {"lowerIsBetter": false, "replicates": [319.2290618157152, 338.726388778194, 372.2294849661201, 376.8285430129291, 379.6052105809956, 19890.20439182433, 20381.777093374407, 20821.375358739242, 21258.0, 21296.148154073857, 20193.49516262094, 20384.592308153828, 20577.897110514463, 21402.501824872266, 21441.57116857662, 5639.802606908759, 5820.825375238739, 5971.5222782177325, 6018.247719035121, 6023.72893219804, 4266.7866606669695, 5545.251391062196, 6345.71444285006, 6640.435562977153, 6646.302138275484, 6507.577007494498, 6561.376669216417, 6579.407853293203, 6582.736690532373, 6584.9012264816065, 6294.968525157391, 6458.483321334282, 6516.511261655347, 6525.249596296439, 6579.671016449182, 5503.724813759296, 5525.751341189616, 5570.777168913239, 5580.079286917654, 5584.86037849053, 26046.869765651052, 26225.73774262252, 26245.343866403302, 26554.93780248788, 26639.33401664974, 2125.2455378340774, 2127.5319429725437, 2149.151085321305, 2304.182015384548, 2900.1734505665786, 9381.671641492516, 9642.228621710246, 9811.950940245324, 14939.925300373538, 15525.922370388076, 1768.3015208992376, 1788.8211178882138, 1826.2421095245456, 1833.8257865502756, 1876.5265394467717, 104926.0, 110520.0, 111049.44475277571, 112001.0, 115064.0, 11133.332000080021, 11207.215494915441, 11208.495617697223, 11365.659030229106, 11412.717456508732, 13643.522476713268, 13679.384427700777, 13686.04197706151, 13703.109297895606, 13733.176009439267, 6987.825304367329, 8662.696805611773, 8705.91294087051, 8742.431741936754, 8828.028916819145, 8826.779330516789, 8890.73327800167, 8937.46375217489, 8980.371374003887, 8999.37004409698, 4394.780260986938, 4485.663575231871, 4494.4606647202545, 4518.186726389215, 4530.139273538017, 1621.5135459362143, 1708.7522309265087, 1758.639478906821, 1896.8672192946638, 1910.1022519415853, 968.5157421289356, 988.6094992477931, 1033.8190816607214, 1053.1943063556384, 1068.8509851909228, 19606.411807645793, 20857.165713371294, 21475.0, 21503.784962150177, 21637.0, 965.9130678238993, 1010.7422607235255, 1013.6604237580345, 1016.7204018894863, 1070.7376692710336, 10821.891781082246, 11129.888701113046, 11224.66326010221, 11255.212135150625, 11255.887441125647, 574712.0, 667095.0, 673286.0, 676074.0, 686629.0, 120191.19713204309, 120857.79142208642, 121588.0, 123982.0, 124578.37710811388, 1062.3041907550567, 1069.9679009629724, 1079.0342643334172, 1079.3847506921136, 1099.126194675219, 18919.716204257224, 19015.049247537292, 19091.140898659873, 19237.903810480857, 19250.326238581583, 52126.0, 52554.0, 52854.0, 53023.40929772113, 54361.456385437225, 74595.0, 75471.0, 75782.48435031378, 77459.45081098459, 77679.61160194162, 7702.884456733042, 7853.8036549084445, 7882.0, 7932.722354717557, 7941.967544219215, 11027.61403350911, 12603.873961260637, 12832.101752877208, 12841.165324253894, 12946.611601651966, 10400.791984160425, 10736.141108711441, 10741.516631751747, 10947.726306842074, 11102.666919992413, 10196.541155647865, 10687.679369618923, 10805.135589152691, 10980.945095274472, 11000.22998390137, 10974.890251097706, 11216.943915280372, 11264.098872090377, 11342.319460832046, 11448.771024579295, 7822.882656760039, 7845.411594130349, 7880.093789214314, 7979.72070977513, 8095.5142691438705, 7604.80987975305, 7848.960755196187, 8070.435069545076, 8359.373047021376, 8395.70615028471], "unit": "score", "name": "jquery.html", "value": 9594.27556269209}, {"lowerIsBetter": false, "replicates": [1585.0885740699098, 1602.1588665950378, 1907.5517253445437, 1978.7526559180103, 1991.9203231870717, 7660.693572257117, 8365.539895305756, 8449.155084491555, 8621.008584012841, 8635.30917526598, 8445.28215101717, 8459.11179326171, 8543.871841922377, 8565.314774818014, 8566.742997710064, 2473.9876300618516, 2487.800975921931, 2492.4516606346574, 2498.350428888493, 2510.3598582361474, 2135.6155891939443, 2426.9393265168424, 2482.950340993188, 2492.8255022148455, 2497.400623850272, 2463.741307162749, 2471.8022558195303, 2477.1453848422266, 2499.5375855466705, 2500.9749902501017, 2464.7781699647117, 2471.876406179693, 2489.9253022409357, 2492.339530024527, 2492.3644470660047, 2453.141400509825, 2476.2942561370105, 2483.0936708101594, 2486.3784053986506, 2492.140211626986, 8588.227059564606, 8588.441751286146, 8617.913820861773, 8636.222739953435, 8719.389642725011, 5253.711045892474, 5350.357957045179, 5380.677159370451, 5403.054465468566, 5435.565154787608, 3288.3752087103376, 3530.293941211768, 3636.254567813592, 3676.9816150919073, 3701.444783282502, 1066.5413872035022, 1077.9819938187748, 1085.9022687958043, 1086.266769930294, 1086.315621158673, 9756.975517570623, 11278.718032049264, 11280.492377843017, 11363.772724545546, 11410.771784564262, 4494.258447356215, 4526.140033393644, 4780.139574876555, 4835.516448355136, 4886.364772579613, 9857.0, 9857.901420985841, 9885.752856178653, 9896.0, 9905.0, 5410.3507579090765, 5422.349318081855, 5434.619576629598, 5444.074507333763, 5467.043267428184, 4333.848315308949, 4770.308305295713, 4866.075445665312, 4869.220924652039, 4945.233488809168, 3829.540455145345, 3908.5700572936953, 3922.666573341298, 3941.8620348287673, 3965.583613720518, 1311.3967574915646, 1319.346923272967, 1322.4379638653534, 1325.1982550556968, 1340.7251513439721, 1186.792311345511, 1364.6861221919014, 1398.7622104242303, 1409.5771268619578, 1415.9079659822078, 7921.603919804102, 7926.643301051467, 7946.483478573874, 7961.442699011013, 7968.880466793003, 507.11761534928957, 519.4156573854414, 524.5122036506086, 524.9186376111709, 526.2133110999005, 6079.270487541435, 6157.538184636171, 6157.9384206157365, 6214.5960512566535, 6224.221972253468, 10127.291089623655, 10339.9483002586, 10435.739106522398, 10475.790484190273, 10514.001169888848, 9712.22302215821, 10229.079382855578, 10252.38485690861, 10284.537195826206, 10317.380957142444, 7937.960310198412, 8065.838683226302, 8074.636641351271, 8148.674053037812, 8152.021757389032, 7843.803904902423, 7868.055833299812, 7925.207479252259, 7933.3653307734085, 7958.3235424989525, 7562.621868906643, 8941.910580894108, 9133.543322833964, 9167.724968250963, 9293.628254869729, 9218.585163667785, 9477.052294770469, 9504.714858554255, 9627.181689556466, 9675.951620241854, 6623.072769812326, 7099.893501597377, 7303.780886573411, 7357.779266621796, 7518.624068796429, 7425.777226683208, 7702.729049706735, 8119.228673276029, 8157.143499932422, 8159.9800024996875, 7203.387712044325, 7298.37963773064, 7314.963425183053, 7417.554946703215, 7445.143808461879, 6942.757003504853, 7048.083749112582, 7064.858702826017, 7158.46311526648, 7231.566106033655, 7461.216572259835, 7489.101307843093, 7533.773986780406, 7548.698052077855, 7567.356774674215, 6811.250762416229, 6851.965740171467, 6854.965725171542, 6873.931260687529, 6893.689783959834, 6828.692708828214, 6938.479614029069, 6950.3049695030095, 6966.303369662993, 7026.473014523829], "unit": "score", "name": "mootools.html", "value": 4784.985206411561}, {"lowerIsBetter": false, "replicates": [315.14595446340417, 336.9932601347973, 337.13188539510764, 340.92158803475195, 342.33074339665956, 6845.760398386057, 6965.1990021147585, 6970.198427180876, 6994.510384273103, 7013.29867013299, 6908.309169083102, 6913.861722765541, 6915.0, 6921.0, 6925.757598484054, 4791.640626952975, 4899.387576552931, 5046.596272298208, 5102.591792656597, 5114.923276150861, 5044.066847633199, 5073.162928116874, 5097.133487307148, 5133.383993920716, 5145.3311069560905, 4073.0, 5047.974760126194, 5081.136206844845, 5101.54086132248, 5103.213875143707, 4135.58644135587, 5071.366079240095, 5072.721000344998, 5077.060743762398, 5077.111505486543, 4340.8697739067875, 4353.477582690066, 4360.563943605645, 4363.869083927487, 4369.71596846204, 6023.427774361428, 6051.576389652726, 6312.305646378894, 6696.330366963313, 6704.83237919051, 5798.869220502003, 5847.8538036549, 5849.0, 5856.857912707023, 5870.706464676792, 5959.493443057346, 5993.550483713695, 7304.634768261566, 7352.926470735278, 7374.041374621265, 4664.976675116636, 4670.719756814602, 4673.228917228653, 4675.1818431774645, 4676.7427791471455, 7374.373178279852, 7726.420518461138, 7815.0, 7839.1768864269, 7850.6859725611475, 4486.955130448719, 4624.907501849944, 4720.079584480994, 4723.197056500403, 4723.858284251478, 4831.758412079382, 4838.685485443505, 4841.249606310957, 4841.830535931225, 4870.512948705172, 4812.230043193073, 5807.216025836543, 5819.621724587888, 5829.242198514251, 5838.357780644125, 7380.151282602462, 7396.704131834774, 7397.593132377663, 7412.369948554326, 7446.0, 1660.4769497608215, 1685.957851053709, 1686.5193419875277, 1689.695854746133, 1695.4998275508754, 1036.388530766851, 1077.0468135699805, 1077.380506208933, 1082.6643740440488, 1086.9891301087046, 6917.342852429011, 6921.653917304115, 6935.410490108397, 6949.478789090838, 6951.617661028692, 5448.42791506894, 6182.845428864314, 7618.847623047508, 7652.923470765221, 7654.693812247448, 6871.553349032297, 6878.621675807779, 6879.105716256855, 6885.690143943534, 6890.724371025203, 3224.967750322514, 3231.4829627259523, 4057.3102572562734, 4064.695147863922, 4074.6332830044844, 5904.321003084614, 7873.488223265469, 7887.645055972495, 8037.638306276232, 8041.557714325651, 6783.118194634666, 7826.921730782733, 7892.4080693947035, 8010.839783204303, 8045.678172873019, 6518.934810651927, 6924.549904256308, 8129.674813007532, 8140.715074972348, 8143.3485321172975, 7432.925670743223, 7699.306152646409, 7724.536527808349, 7740.961295193713, 7752.341051010501, 7532.17146113938, 7556.6977320908745, 7565.43259255547, 7572.318491335806, 7585.0, 6955.374016338554, 8104.351651867954, 8105.8378832424205, 8109.02691676979, 8113.594320283844, 3947.4276229947072, 4627.5141110184295, 4740.170470167775, 4756.762161891822, 4760.0, 6464.8707025858275, 7196.280371962971, 7274.527155734861, 7678.424118191047, 7708.421868359784, 6574.980877963923, 6851.691673874788, 7388.187299397169, 7404.925950740424, 7416.0, 7389.8522029558035, 7406.666699998621, 7411.332980031823, 7415.703371865281, 7417.480776345604, 7171.211166771546, 7177.0, 7185.353318201178, 7196.640167991684, 7218.819529511804, 7191.316824901626, 7411.518251313647, 7422.220666829905, 7438.293362130589, 7447.0, 7177.784666460015, 7230.385417239383, 7234.710611575478, 7256.129264488084, 7262.491625586158], "unit": "score", "name": "prototype.html", "value": 5288.877176211271}, {"lowerIsBetter": false, "replicates": [721.9747308844192, 758.8406434648723, 767.2940894377174, 783.7100272899024, 801.8035581282587, 15116.773248401269, 15242.085474871516, 15354.155521446315, 15359.0, 15389.69220615587, 14395.78406323906, 14402.423903043866, 14486.637834054154, 14602.415903363853, 14645.121292722444, 777.8910952466659, 929.1823195587873, 952.2144231009411, 964.8456247000481, 967.4243824924159, 967.5500892085179, 970.8883478400004, 972.6352617768337, 977.968243503104, 978.6574698855414, 1016.6695823857239, 1028.090140225898, 1031.4997226345217, 1032.1072272484323, 1037.8858325584179, 1014.06705830636, 1017.2269075502671, 1021.4331046269317, 1023.5138309303096, 1024.0834453164414, 747.9887801682979, 756.3004221095465, 767.9747537038061, 771.4252881603186, 774.8372841703249, 15156.31796569146, 15160.241987900672, 15189.772153417707, 15189.848101519065, 15198.0, 11397.259178153394, 12813.295268760308, 12835.294058826761, 13092.952563794874, 13094.410751516109, 8096.959515202387, 9595.376300540442, 9734.36726612768, 9754.561044753003, 9758.170555502791, 3459.5848498180126, 3498.667626575497, 3549.467579863041, 3599.0102721751728, 3619.49327094207, 80118.98512685914, 81491.5925420375, 82025.0, 82312.58843705803, 82600.17399825985, 7031.0, 9109.99790023097, 9251.44491330509, 9256.814863702688, 9302.488363139957, 20463.8976805115, 20552.794472055088, 20563.794362056487, 20723.585528289652, 20736.792632073786, 6722.462203023844, 7133.964330178316, 7271.709131634675, 7355.926440735631, 7389.81525461857, 3846.769193848378, 3879.228737980159, 3987.4616926715103, 4019.738716983387, 4024.9798751006056, 3004.8798048077833, 3536.504889315498, 3547.9822600887346, 3562.3943929532043, 3608.1160115771804, 643.1799455694028, 644.432899048834, 655.5837043477426, 656.4256275758711, 659.1003280522053, 546.4126064480699, 570.4010788671878, 593.0836857055859, 599.7211296746947, 600.0459269761101, 6944.652767361713, 7972.123066462685, 8147.470414423044, 8170.754877353689, 8265.504069755834, 553.2586334312041, 592.141394977276, 608.8599622086945, 623.4700504571169, 632.8418993242356, 3558.7508874379064, 3580.98209508956, 3780.4896338993885, 3813.904652383713, 3859.980700096538, 86760.0, 89122.0, 90179.64730529048, 99273.50363248137, 99810.0, 76391.85412218822, 76808.0, 77199.2280077192, 77674.0, 78498.0, 68050.0, 68352.97470537847, 68672.4159480065, 68689.65655171692, 70002.0, 8446.408751387344, 8446.577671116542, 8558.700445484377, 8583.18459746323, 8669.263112635497, 48334.27498587454, 49112.263316051, 49204.75397622989, 49234.75382623064, 49513.0, 55904.72047639736, 66072.66963665343, 67208.0, 67322.66338668275, 67599.3240067593, 10754.677359679223, 10814.675559733221, 10898.182636302468, 11043.392613406018, 11249.606263780728, 11727.648170554898, 11965.16243862956, 12018.75962480763, 12035.819462708241, 12322.75354492923, 11430.71423214393, 11642.185047046625, 11670.70823229426, 11731.589394371156, 11763.235389699643, 9433.669821556212, 10772.892271077502, 11298.4915678793, 11334.773304534028, 11424.0, 11090.500927458123, 11119.499622517167, 11157.66527004191, 11439.828402574134, 11809.23239989398, 9503.239740820856, 9613.311506827471, 9632.422054676741, 9710.514474276117, 9901.702948911545, 7198.8920166198595, 8075.651157446695, 9378.390404623678, 9381.827271591052, 9812.65655702047], "unit": "score", "name": "yui.html", "value": 6907.197930006}], "name": "dromaeo_css", "value": 7543.388259011882}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 95.0, 166.0, 167.0, 183.0, 114.0, 114.0, 115.0, 114.0], "unit": "score", "name": "ai-astar", "value": 128.9}, {"lowerIsBetter": true, "replicates": [191.0, 112.0, 187.0, 185.0, 154.0, 170.0, 152.0, 119.0, 158.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 155.0}, {"lowerIsBetter": true, "replicates": [191.0, 195.0, 195.0, 244.0, 264.0, 234.0, 215.0, 175.0, 264.0, 274.0], "unit": "score", "name": "audio-dft", "value": 225.1}, {"lowerIsBetter": true, "replicates": [74.0, 67.0, 69.0, 152.0, 80.0, 60.0, 56.0, 59.0, 126.0, 57.0], "unit": "score", "name": "audio-fft", "value": 80.0}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 123.0, 79.0, 81.0, 81.0, 124.0, 79.0, 78.0, 122.0], "unit": "score", "name": "audio-oscillator", "value": 94.0}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 79.0, 129.0, 134.0, 86.0, 91.0, 86.0, 87.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 95.1}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 95.0, 93.0, 94.0, 94.0, 93.0, 94.0, 96.0, 120.0], "unit": "score", "name": "imaging-darkroom", "value": 96.6}, {"lowerIsBetter": true, "replicates": [98.0, 153.0, 91.0, 91.0, 98.0, 92.0, 92.0, 91.0, 90.0, 140.0], "unit": "score", "name": "imaging-desaturate", "value": 103.6}, {"lowerIsBetter": true, "replicates": [54.0, 57.0, 54.0, 57.0, 57.0, 56.0, 55.0, 65.0, 57.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 74.0, 73.0, 80.0, 73.0, 70.0, 69.0, 66.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.4}, {"lowerIsBetter": true, "replicates": [76.0, 105.0, 111.0, 83.0, 83.0, 85.0, 85.0, 85.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.2}, {"lowerIsBetter": true, "replicates": [125.0, 126.0, 132.0, 138.0, 141.0, 125.0, 126.0, 132.0, 129.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.5}, {"lowerIsBetter": true, "replicates": [129.0, 141.0, 142.0, 127.0, 162.0, 181.0, 183.0, 140.0, 141.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.9}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 67.0, 69.0, 68.0, 89.0, 95.0, 97.0, 79.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 77.2}], "name": "kraken", "value": 1549.9000000000003}]} 14:41:59 INFO - Return code: 0 14:41:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:41:59 ERROR - # TBPL SUCCESS # 14:41:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:41:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:41:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:41:59 INFO - 2016-03-16 14:41:59.586 screenresolution[2302:20479] starting screenresolution argv=screenresolution get 14:41:59 INFO - 2016-03-16 14:41:59.589 screenresolution[2302:20479] Display 0: 1600x1200x32@60 14:41:59 INFO - 2016-03-16 14:41:59.595 screenresolution[2303:20482] starting screenresolution argv=screenresolution list 14:41:59 INFO - Available Modes on Display 0 14:41:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:41:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:41:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:41:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:41:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:41:59 INFO - Intel Iris: 14:41:59 INFO - Chipset Model: Intel Iris 14:41:59 INFO - Type: GPU 14:41:59 INFO - Bus: Built-In 14:41:59 INFO - VRAM (Dynamic, Max): 1536 MB 14:41:59 INFO - Vendor: Intel (0x8086) 14:41:59 INFO - Device ID: 0x0a2e 14:41:59 INFO - Revision ID: 0x0009 14:41:59 INFO - Displays: 14:41:59 INFO - Display: 14:41:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:41:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:41:59 INFO - Display Serial Number: 1600x1200 60 14:41:59 INFO - Main Display: Yes 14:41:59 INFO - Mirror: Off 14:41:59 INFO - Online: Yes 14:41:59 INFO - Rotation: Supported 14:41:59 INFO - Return code: 0 14:41:59 INFO - Running post-action listener: _resource_record_post_action 14:41:59 INFO - Running post-run listener: _resource_record_post_run 14:42:00 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 200704; Write bytes: 706688000; Read time: 3; Write time: 2046 14:42:00 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 384872960; Write bytes: 379033600; Read time: 28699; Write time: 813 14:42:00 INFO - run-tests - Wall time: 1171s; CPU: 54.0%; Read bytes: 200704; Write bytes: 302750720; Read time: 3; Write time: 1184 14:42:00 INFO - Running post-run listener: _upload_blobber_files 14:42:00 INFO - Blob upload gear active. 14:42:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:42:00 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 14:42:00 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'] 14:42:00 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 14:42:01 INFO - (blobuploader) - INFO - Open directory for files ... 14:42:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:42:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:42:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:01 INFO - (blobuploader) - INFO - Done attempting. 14:42:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:42:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:42:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:02 INFO - (blobuploader) - INFO - Done attempting. 14:42:02 INFO - (blobuploader) - INFO - Iteration through files over. 14:42:02 INFO - Return code: 0 14:42:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:42:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:42:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cf404318675ccaaa265d233b3c077f9ac342e5153b9ba1de9a250061061b5afab180850175f12f6c9464e66de741f04afee7859df5f41b4d514bc148394fb52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42dd0ff7a0c606cd364fe21572e61fcbb219d6e583f945de72799d610789ce83419dea94715c6dd34e43beea28ceaa58521609b1b8419f3633ec1be7dea97fc0"} 14:42:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:42:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:42:02 INFO - Contents: 14:42:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9cf404318675ccaaa265d233b3c077f9ac342e5153b9ba1de9a250061061b5afab180850175f12f6c9464e66de741f04afee7859df5f41b4d514bc148394fb52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42dd0ff7a0c606cd364fe21572e61fcbb219d6e583f945de72799d610789ce83419dea94715c6dd34e43beea28ceaa58521609b1b8419f3633ec1be7dea97fc0"} 14:42:02 INFO - Running post-run listener: copy_logs_to_upload_dir 14:42:02 INFO - Copying logs to upload dir... 14:42:02 INFO - mkdir: /builds/slave/test/build/upload/logs 14:42:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.921019 ========= master_lag: 6.88 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-03-16 14:42:09.403813) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 14:42:09.407307) ========= 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.spUWm4vWXM/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.fRhIL4QAfp/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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/9cf404318675ccaaa265d233b3c077f9ac342e5153b9ba1de9a250061061b5afab180850175f12f6c9464e66de741f04afee7859df5f41b4d514bc148394fb52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42dd0ff7a0c606cd364fe21572e61fcbb219d6e583f945de72799d610789ce83419dea94715c6dd34e43beea28ceaa58521609b1b8419f3633ec1be7dea97fc0"} build_url:https://queue.taskcluster.net/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/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/9cf404318675ccaaa265d233b3c077f9ac342e5153b9ba1de9a250061061b5afab180850175f12f6c9464e66de741f04afee7859df5f41b4d514bc148394fb52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42dd0ff7a0c606cd364fe21572e61fcbb219d6e583f945de72799d610789ce83419dea94715c6dd34e43beea28ceaa58521609b1b8419f3633ec1be7dea97fc0"}' ========= master_lag: 0.98 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 14:42:10.396633) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-03-16 14:42:10.396961) ========= 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.spUWm4vWXM/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.fRhIL4QAfp/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.005290 ========= master_lag: 4.89 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-03-16 14:42:15.292110) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 14:42:15.292409) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 14:42:15.425625) ========= ========= Total master_lag: 29.26 =========