builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0189 starttime: 1462791845.47 results: success (0) buildid: 20160509021645 builduid: 4bdfeeee93334929abd2f75de36800c0 revision: fd8bdef8ef752875c509141b3345ab9e722d6cec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 04:04:05.473540) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 04:04:05.474271) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 04:04:05.474747) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 04:04:05.507604) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:04:05.508056) ========= 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.lkf3N2gJav/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.wH88tey5bc/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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-05-09 04:04:05-- 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% 37.1M=0s 2016-05-09 04:04:06 (37.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.705739 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:04:06.232157) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:04:06.232810) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lkf3N2gJav/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.wH88tey5bc/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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.020211 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:04:06.283491) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 04:04:06.283969) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fd8bdef8ef752875c509141b3345ab9e722d6cec --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 fd8bdef8ef752875c509141b3345ab9e722d6cec --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lkf3N2gJav/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.wH88tey5bc/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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-05-09 04:04:06,352 truncating revision to first 12 chars 2016-05-09 04:04:06,352 Setting DEBUG logging. 2016-05-09 04:04:06,352 attempt 1/10 2016-05-09 04:04:06,352 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fd8bdef8ef75?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 04:04:07,221 unpacking tar archive at: mozilla-central-fd8bdef8ef75/testing/mozharness/ program finished with exit code 0 elapsedTime=1.113473 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 04:04:07.414039) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 04:04:07.414437) ========= script_repo_revision: fd8bdef8ef752875c509141b3345ab9e722d6cec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 04:04:07.414842) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 04:04:07.415109) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 04:04:07.428581) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-05-09 04:04:07.428993) ========= /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.lkf3N2gJav/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.wH88tey5bc/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 04:04:07 INFO - MultiFileLogger online at 20160509 04:04:07 in /builds/slave/test 04:04:07 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 04:04:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:04:07 INFO - {'append_to_log': False, 04:04:07 INFO - 'base_work_dir': '/builds/slave/test', 04:04:07 INFO - 'blob_upload_branch': 'Firefox', 04:04:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:04:07 INFO - 'branch': 'Firefox', 04:04:07 INFO - 'buildbot_json_path': 'buildprops.json', 04:04:07 INFO - 'config_files': ('talos/mac_config.py',), 04:04:07 INFO - 'default_actions': ('clobber', 04:04:07 INFO - 'read-buildbot-config', 04:04:07 INFO - 'download-and-extract', 04:04:07 INFO - 'populate-webroot', 04:04:07 INFO - 'create-virtualenv', 04:04:07 INFO - 'install', 04:04:07 INFO - 'run-tests'), 04:04:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:04:07 INFO - 'download_minidump_stackwalk': True, 04:04:07 INFO - 'download_symbols': 'ondemand', 04:04:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:04:07 INFO - 'tooltool.py': '/tools/tooltool.py', 04:04:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:04:07 INFO - '/tools/misc-python/virtualenv.py')}, 04:04:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:04:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:04:07 INFO - 'installer_path': 'installer.exe', 04:04:07 INFO - 'log_level': 'info', 04:04:07 INFO - 'log_name': 'talos', 04:04:07 INFO - 'log_to_console': True, 04:04:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:04:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:04:07 INFO - 'opt_config_files': (), 04:04:07 INFO - 'pip_index': False, 04:04:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:04:07 INFO - 'cmd': ('bash', 04:04:07 INFO - '-c', 04:04:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:04:07 INFO - 'enabled': True, 04:04:07 INFO - 'halt_on_failure': False, 04:04:07 INFO - 'name': 'check_screen_resolution'},), 04:04:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:04:07 INFO - 'cmd': ('bash', 04:04:07 INFO - '-c', 04:04:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:04:07 INFO - 'enabled': True, 04:04:07 INFO - 'halt_on_failure': False, 04:04:07 INFO - 'name': 'check_screen_resolution'},), 04:04:07 INFO - 'run_cmd_checks_enabled': True, 04:04:07 INFO - 'sps_profile': False, 04:04:07 INFO - 'sps_profile_interval': 0, 04:04:07 INFO - 'suite': 'dromaeojs-e10s', 04:04:07 INFO - 'system_bits': '32', 04:04:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:04:07 INFO - 'title': 't-yosemite-r7-0189', 04:04:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:04:07 INFO - 'use_talos_json': True, 04:04:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:04:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:04:07 INFO - 'work_dir': 'build'} 04:04:07 INFO - ##### 04:04:07 INFO - ##### Running clobber step. 04:04:07 INFO - ##### 04:04:07 INFO - Running pre-action listener: _resource_record_pre_action 04:04:07 INFO - Running main action method: clobber 04:04:07 INFO - rmtree: /builds/slave/test/build 04:04:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:04:09 INFO - Running post-action listener: _resource_record_post_action 04:04:09 INFO - ##### 04:04:09 INFO - ##### Finished clobber step (success) 04:04:09 INFO - ##### 04:04:09 INFO - ##### 04:04:09 INFO - ##### Running read-buildbot-config step. 04:04:09 INFO - ##### 04:04:09 INFO - Running pre-action listener: _resource_record_pre_action 04:04:09 INFO - Running main action method: read_buildbot_config 04:04:09 INFO - Using buildbot properties: 04:04:09 INFO - { 04:04:09 INFO - "project": "", 04:04:09 INFO - "product": "firefox", 04:04:09 INFO - "script_repo_revision": "production", 04:04:09 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:04:09 INFO - "repository": "", 04:04:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:04:09 INFO - "buildid": "20160509021645", 04:04:09 INFO - "pgo_build": "False", 04:04:09 INFO - "basedir": "/builds/slave/test", 04:04:09 INFO - "buildnumber": 2, 04:04:09 INFO - "slavename": "t-yosemite-r7-0189", 04:04:09 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 04:04:09 INFO - "platform": "yosemite_r7", 04:04:09 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:04:09 INFO - "branch": "mozilla-central", 04:04:09 INFO - "repo_path": "mozilla-central", 04:04:09 INFO - "revision": "fd8bdef8ef752875c509141b3345ab9e722d6cec", 04:04:09 INFO - "stage_platform": "macosx64", 04:04:09 INFO - "builduid": "4bdfeeee93334929abd2f75de36800c0", 04:04:09 INFO - "slavebuilddir": "test" 04:04:09 INFO - } 04:04:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 04:04:09 INFO - Running post-action listener: _resource_record_post_action 04:04:09 INFO - ##### 04:04:09 INFO - ##### Finished read-buildbot-config step (success) 04:04:09 INFO - ##### 04:04:09 INFO - ##### 04:04:09 INFO - ##### Running download-and-extract step. 04:04:09 INFO - ##### 04:04:09 INFO - Running pre-action listener: _resource_record_pre_action 04:04:09 INFO - Running main action method: download_and_extract 04:04:09 INFO - mkdir: /builds/slave/test/build/tests 04:04:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:09 INFO - https://queue.taskcluster.net/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:04:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 04:04:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 04:04:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 04:04:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 04:04:11 INFO - Downloaded 1199 bytes. 04:04:11 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 04:04:11 INFO - Using the following test package requirements: 04:04:11 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 04:04:11 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:04:11 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 04:04:11 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:04:11 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 04:04:11 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:04:11 INFO - u'jsshell-mac.zip'], 04:04:11 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:04:11 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 04:04:11 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 04:04:11 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:04:11 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 04:04:11 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:04:11 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 04:04:11 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:04:11 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 04:04:11 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:04:11 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 04:04:11 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:11 INFO - https://queue.taskcluster.net/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:04:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:04:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:04:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:04:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:04:13 INFO - Downloaded 18144981 bytes. 04:04:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:04:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:04:16 INFO - Return code: 0 04:04:16 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:04: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')]} 04:04:16 INFO - https://queue.taskcluster.net/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:04:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:04:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:04:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:04:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:04:17 INFO - Downloaded 18144981 bytes. 04:04:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:04:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:04:20 INFO - Return code: 0 04:04:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:20 INFO - https://queue.taskcluster.net/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:04:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 04:04:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 04:04:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 04:04:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:04:22 INFO - Downloaded 10840152 bytes. 04:04:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:04:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:04:22 INFO - Return code: 0 04:04:22 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')]} 04:04:22 INFO - https://queue.taskcluster.net/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:04:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 04:04:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 04:04:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 04:04:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 04:04:25 INFO - Downloaded 110317300 bytes. 04:04:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 04:04:25 INFO - mkdir: /builds/slave/test/properties 04:04:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:04:25 INFO - Writing to file /builds/slave/test/properties/build_url 04:04:25 INFO - Contents: 04:04:25 INFO - build_url:https://queue.taskcluster.net/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 04:04:26 INFO - Running post-action listener: _resource_record_post_action 04:04:26 INFO - Running post-action listener: set_extra_try_arguments 04:04:26 INFO - ##### 04:04:26 INFO - ##### Finished download-and-extract step (success) 04:04:26 INFO - ##### 04:04:26 INFO - ##### 04:04:26 INFO - ##### Running populate-webroot step. 04:04:26 INFO - ##### 04:04:26 INFO - Running pre-action listener: _resource_record_pre_action 04:04:26 INFO - Running main action method: populate_webroot 04:04:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:04:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:04:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:04:26 INFO - '--tppagecycles', 04:04:26 INFO - '7'], 04:04:26 INFO - 'tests': ['tsvgm']}}, 04:04:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:04:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:04:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:04:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:04:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:04:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:04:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:26 INFO - 'talos_options': ['--disable-e10s'], 04:04:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:04:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:04:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:26 INFO - 'talos_options': ['--disable-e10s'], 04:04:26 INFO - 'tests': ['damp', 'tps']}, 04:04:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:26 INFO - 'tests': ['damp', 'tps']}, 04:04:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:04:26 INFO - 'tests': ['dromaeo_dom']}, 04:04:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:04:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:04:26 INFO - 'tests': ['a11yr', 04:04:26 INFO - 'ts_paint', 04:04:26 INFO - 'tpaint', 04:04:26 INFO - 'sessionrestore', 04:04:26 INFO - 'sessionrestore_no_auto_restore', 04:04:26 INFO - 'tabpaint']}, 04:04:26 INFO - 'other-e10s': {'tests': ['a11yr', 04:04:26 INFO - 'ts_paint', 04:04:26 INFO - 'tpaint', 04:04:26 INFO - 'sessionrestore', 04:04:26 INFO - 'sessionrestore_no_auto_restore', 04:04:26 INFO - 'tabpaint']}, 04:04:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:04:26 INFO - 'ts_paint', 04:04:26 INFO - 'tpaint', 04:04:26 INFO - 'sessionrestore', 04:04:26 INFO - 'sessionrestore_no_auto_restore', 04:04:26 INFO - 'tabpaint']}, 04:04:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:04:26 INFO - 'ts_paint', 04:04:26 INFO - 'tpaint', 04:04:26 INFO - 'sessionrestore', 04:04:26 INFO - 'sessionrestore_no_auto_restore', 04:04:26 INFO - 'tabpaint']}, 04:04:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:04:26 INFO - 'tests': ['a11yr', 04:04:26 INFO - 'ts_paint', 04:04:26 INFO - 'tpaint', 04:04:26 INFO - 'sessionrestore', 04:04:26 INFO - 'sessionrestore_no_auto_restore', 04:04:26 INFO - 'tabpaint']}, 04:04:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:04:26 INFO - 'tests': ['a11yr', 04:04:26 INFO - 'ts_paint', 04:04:26 INFO - 'tpaint', 04:04:26 INFO - 'sessionrestore', 04:04:26 INFO - 'sessionrestore_no_auto_restore', 04:04:26 INFO - 'tabpaint']}, 04:04:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:04:26 INFO - 'tests': ['tsvgx', 04:04:26 INFO - 'tsvgr_opacity', 04:04:26 INFO - 'tart', 04:04:26 INFO - 'tscrollx', 04:04:26 INFO - 'cart']}, 04:04:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:04:26 INFO - 'tsvgr_opacity', 04:04:26 INFO - 'tart', 04:04:26 INFO - 'tscrollx', 04:04:26 INFO - 'cart']}, 04:04:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:26 INFO - 'talos_options': ['--disable-e10s'], 04:04:26 INFO - 'tests': ['tp5o']}, 04:04:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:26 INFO - 'tests': ['tp5o']}, 04:04:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:26 INFO - 'talos_options': ['--disable-e10s', 04:04:26 INFO - '--xperf_path', 04:04:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:04:26 INFO - 'tests': ['tp5n']}, 04:04:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:26 INFO - 'talos_options': ['--xperf_path', 04:04:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:04:26 INFO - 'tests': ['tp5n']}}, 04:04:26 INFO - 'talos.zip': {'path': '', 04:04:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:04:26 INFO - Running post-action listener: _resource_record_post_action 04:04:26 INFO - ##### 04:04:26 INFO - ##### Finished populate-webroot step (success) 04:04:26 INFO - ##### 04:04:26 INFO - ##### 04:04:26 INFO - ##### Running create-virtualenv step. 04:04:26 INFO - ##### 04:04:26 INFO - Running pre-action listener: _resource_record_pre_action 04:04:26 INFO - Running main action method: create_virtualenv 04:04:26 INFO - Creating virtualenv /builds/slave/test/build/venv 04:04:26 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 04:04:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:04:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:04:27 INFO - Using real prefix '/tools/python27' 04:04:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:04:27 INFO - Installing distribute.............................................................................................................................................................................................done. 04:04:30 INFO - Installing pip.................done. 04:04:30 INFO - Return code: 0 04:04:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:30 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 0x10649ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f867bc66c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10633fd30>, '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 0x106163db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106336b20>, '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.lkf3N2gJav/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.wH88tey5bc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 04:04:30 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 04:04:30 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 04:04:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lkf3N2gJav/Render', 04:04:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:30 INFO - 'HOME': '/Users/cltbld', 04:04:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:30 INFO - 'LOGNAME': 'cltbld', 04:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:30 INFO - 'MOZ_NO_REMOTE': '1', 04:04:30 INFO - 'NO_EM_RESTART': '1', 04:04:30 INFO - 'PAGER': '/bin/cat', 04:04:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:30 INFO - 'PWD': '/builds/slave/test', 04:04:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:30 INFO - 'SHELL': '/bin/bash', 04:04:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wH88tey5bc/Listeners', 04:04:30 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 04:04:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:30 INFO - 'USER': 'cltbld', 04:04:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:30 INFO - 'XPC_FLAGS': '0x0', 04:04:30 INFO - 'XPC_SERVICE_NAME': '0', 04:04:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:31 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 04:04:31 INFO - Cleaning up... 04:04:31 INFO - Return code: 0 04:04:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10649ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f867bc66c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10633fd30>, '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 0x106163db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106336b20>, '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.lkf3N2gJav/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.wH88tey5bc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 04:04:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:04:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:04:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lkf3N2gJav/Render', 04:04:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:31 INFO - 'HOME': '/Users/cltbld', 04:04:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:31 INFO - 'LOGNAME': 'cltbld', 04:04:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:31 INFO - 'MOZ_NO_REMOTE': '1', 04:04:31 INFO - 'NO_EM_RESTART': '1', 04:04:31 INFO - 'PAGER': '/bin/cat', 04:04:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:31 INFO - 'PWD': '/builds/slave/test', 04:04:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:31 INFO - 'SHELL': '/bin/bash', 04:04:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wH88tey5bc/Listeners', 04:04:31 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 04:04:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:31 INFO - 'USER': 'cltbld', 04:04:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:31 INFO - 'XPC_FLAGS': '0x0', 04:04:31 INFO - 'XPC_SERVICE_NAME': '0', 04:04:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:31 INFO - Downloading/unpacking psutil>=0.7.1 04:04:31 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 04:04:31 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 04:04:31 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 04:04:31 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 04:04:31 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 04:04:31 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 04:04:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:04:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:04:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:04:34 INFO - Installing collected packages: psutil 04:04:34 INFO - Running setup.py install for psutil 04:04:34 INFO - building 'psutil._psutil_osx' extension 04:04:34 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 04:04:35 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 04:04:35 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 04:04:35 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 04:04:35 INFO - building 'psutil._psutil_posix' extension 04:04:35 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 04:04:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:04:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:04:35 INFO - ^ 04:04:35 INFO - 1 warning generated. 04:04:35 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 04:04:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:04:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:04:35 INFO - Successfully installed psutil 04:04:35 INFO - Cleaning up... 04:04:35 INFO - Return code: 0 04:04:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10649ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f867bc66c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10633fd30>, '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 0x106163db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106336b20>, '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.lkf3N2gJav/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.wH88tey5bc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 04:04:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:04:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:04:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lkf3N2gJav/Render', 04:04:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:35 INFO - 'HOME': '/Users/cltbld', 04:04:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:35 INFO - 'LOGNAME': 'cltbld', 04:04:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:35 INFO - 'MOZ_NO_REMOTE': '1', 04:04:35 INFO - 'NO_EM_RESTART': '1', 04:04:35 INFO - 'PAGER': '/bin/cat', 04:04:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:35 INFO - 'PWD': '/builds/slave/test', 04:04:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:35 INFO - 'SHELL': '/bin/bash', 04:04:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wH88tey5bc/Listeners', 04:04:35 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 04:04:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:35 INFO - 'USER': 'cltbld', 04:04:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:35 INFO - 'XPC_FLAGS': '0x0', 04:04:35 INFO - 'XPC_SERVICE_NAME': '0', 04:04:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:04:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:04:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:04:38 INFO - Installing collected packages: mozsystemmonitor 04:04:38 INFO - Running setup.py install for mozsystemmonitor 04:04:38 INFO - Successfully installed mozsystemmonitor 04:04:38 INFO - Cleaning up... 04:04:38 INFO - Return code: 0 04:04:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:38 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 0x10649ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f867bc66c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10633fd30>, '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 0x106163db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106336b20>, '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.lkf3N2gJav/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.wH88tey5bc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 04:04:38 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 04:04:38 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 04:04:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lkf3N2gJav/Render', 04:04:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:38 INFO - 'HOME': '/Users/cltbld', 04:04:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:38 INFO - 'LOGNAME': 'cltbld', 04:04:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:38 INFO - 'MOZ_NO_REMOTE': '1', 04:04:38 INFO - 'NO_EM_RESTART': '1', 04:04:38 INFO - 'PAGER': '/bin/cat', 04:04:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:38 INFO - 'PWD': '/builds/slave/test', 04:04:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:38 INFO - 'SHELL': '/bin/bash', 04:04:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wH88tey5bc/Listeners', 04:04:38 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 04:04:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:38 INFO - 'USER': 'cltbld', 04:04:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:38 INFO - 'XPC_FLAGS': '0x0', 04:04:38 INFO - 'XPC_SERVICE_NAME': '0', 04:04:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:38 INFO - Downloading/unpacking blobuploader==1.2.4 04:04:38 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 04:04:38 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 04:04:38 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 04:04:38 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 04:04:38 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 04:04:38 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 04:04:41 INFO - Downloading blobuploader-1.2.4.tar.gz 04:04:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:04:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:04:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:42 INFO - Downloading docopt-0.6.1.tar.gz 04:04:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:04:42 INFO - Installing collected packages: blobuploader, requests, docopt 04:04:42 INFO - Running setup.py install for blobuploader 04:04:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:04:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:04:42 INFO - Running setup.py install for requests 04:04:43 INFO - Running setup.py install for docopt 04:04:43 INFO - Successfully installed blobuploader requests docopt 04:04:43 INFO - Cleaning up... 04:04:43 INFO - Return code: 0 04:04:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:04:43 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')]} 04:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:43 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')]} 04:04:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:43 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 0x10649ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f867bc66c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10633fd30>, '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 0x106163db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106336b20>, '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.lkf3N2gJav/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.wH88tey5bc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 04:04:43 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 04:04:43 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 04:04:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lkf3N2gJav/Render', 04:04:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:43 INFO - 'HOME': '/Users/cltbld', 04:04:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:43 INFO - 'LOGNAME': 'cltbld', 04:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:43 INFO - 'MOZ_NO_REMOTE': '1', 04:04:43 INFO - 'NO_EM_RESTART': '1', 04:04:43 INFO - 'PAGER': '/bin/cat', 04:04:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:43 INFO - 'PWD': '/builds/slave/test', 04:04:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:43 INFO - 'SHELL': '/bin/bash', 04:04:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wH88tey5bc/Listeners', 04:04:43 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 04:04:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:43 INFO - 'USER': 'cltbld', 04:04:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:43 INFO - 'XPC_FLAGS': '0x0', 04:04:43 INFO - 'XPC_SERVICE_NAME': '0', 04:04:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:04:43 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-OM8uxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:04:43 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-WsQ8fp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:04:43 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-F7g4og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:04:43 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-u5Xhf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:04:44 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-JPuBio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:04:44 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-4Py3sr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:04:44 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-qKmjHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:04:44 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-GvYOZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:04:44 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-XDdTOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:04:44 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-_antgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:04:44 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-L7qW7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:04:44 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-LBlm_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:04:44 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-_t6k97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:04:44 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-fyyAjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:04:45 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-WoQExo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:04:45 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-VN8vgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:04:45 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-Z09Vuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:04:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:04:45 INFO - Running setup.py install for manifestparser 04:04:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:04:45 INFO - Running setup.py install for mozcrash 04:04:45 INFO - Running setup.py install for mozdebug 04:04:45 INFO - Running setup.py install for mozdevice 04:04:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:04:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:04:45 INFO - Running setup.py install for mozfile 04:04:46 INFO - Running setup.py install for mozhttpd 04:04:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:04:46 INFO - Running setup.py install for mozinfo 04:04:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:04:46 INFO - Running setup.py install for mozInstall 04:04:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:04:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:04:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:04:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:04:46 INFO - Running setup.py install for mozleak 04:04:46 INFO - Running setup.py install for mozlog 04:04:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:04:46 INFO - Running setup.py install for moznetwork 04:04:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:04:46 INFO - Running setup.py install for mozprocess 04:04:47 INFO - Running setup.py install for mozprofile 04:04:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:04:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:04:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:04:47 INFO - Running setup.py install for mozrunner 04:04:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:04:47 INFO - Running setup.py install for mozscreenshot 04:04:47 INFO - Running setup.py install for moztest 04:04:47 INFO - Running setup.py install for mozversion 04:04:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:04:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:04:47 INFO - Cleaning up... 04:04:47 INFO - Return code: 0 04:04:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:04: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')]} 04:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04: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')]} 04:04:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:47 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 0x10649ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f867bc66c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10633fd30>, '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 0x106163db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106336b20>, '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.lkf3N2gJav/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.wH88tey5bc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 04:04:47 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 04:04:47 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 04:04:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lkf3N2gJav/Render', 04:04:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:47 INFO - 'HOME': '/Users/cltbld', 04:04:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:47 INFO - 'LOGNAME': 'cltbld', 04:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:47 INFO - 'MOZ_NO_REMOTE': '1', 04:04:47 INFO - 'NO_EM_RESTART': '1', 04:04:47 INFO - 'PAGER': '/bin/cat', 04:04:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:47 INFO - 'PWD': '/builds/slave/test', 04:04:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:47 INFO - 'SHELL': '/bin/bash', 04:04:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wH88tey5bc/Listeners', 04:04:47 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 04:04:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:47 INFO - 'USER': 'cltbld', 04:04:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:47 INFO - 'XPC_FLAGS': '0x0', 04:04:47 INFO - 'XPC_SERVICE_NAME': '0', 04:04:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:04:48 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-bb1eyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:04:48 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)) 04:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:04:48 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-n1eB1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:04:48 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)) 04:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:04:48 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-FIJi3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:04:48 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)) 04:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:04:48 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-oRiJwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:04:48 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)) 04:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:04:48 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-keK0qP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:04:48 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)) 04:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:04:48 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-kwPBQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:04:48 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)) 04:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:04:48 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-szMAn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:04:48 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)) 04:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:04:48 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-AomCxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:04:49 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)) 04:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:04:49 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-3R5wWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:04:49 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)) 04:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:04:49 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-RmEyPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:04:49 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)) 04:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:04:49 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-Q9cbts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:04:49 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)) 04:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:04:49 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-gHEtIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:04:49 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)) 04:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:04:49 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-cZHSKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:04:49 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)) 04:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:04:49 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-DYkPlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:04:49 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)) 04:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:04:49 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-RR3xlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:04:49 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)) 04:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:04:49 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-BUEWUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:04:49 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)) 04:04:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:04:49 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-aLd8OC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:04:49 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)) 04:04:49 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)) 04:04:49 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)) 04:04:49 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)) 04:04:49 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)) 04:04:49 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)) 04:04:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:52 INFO - Downloading blessings-1.6.tar.gz 04:04:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:04:52 INFO - Installing collected packages: blessings 04:04:52 INFO - Running setup.py install for blessings 04:04:52 INFO - Successfully installed blessings 04:04:52 INFO - Cleaning up... 04:04:52 INFO - Return code: 0 04:04:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:04:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:04:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:04:52 INFO - Reading from file tmpfile_stdout 04:04:52 INFO - Current package versions: 04:04:52 INFO - blessings == 1.6 04:04:52 INFO - blobuploader == 1.2.4 04:04:52 INFO - docopt == 0.6.1 04:04:52 INFO - manifestparser == 1.1 04:04:52 INFO - mozInstall == 1.12 04:04:52 INFO - mozcrash == 0.17 04:04:52 INFO - mozdebug == 0.1 04:04:52 INFO - mozdevice == 0.48 04:04:52 INFO - mozfile == 1.2 04:04:52 INFO - mozhttpd == 0.7 04:04:52 INFO - mozinfo == 0.9 04:04:52 INFO - mozleak == 0.1 04:04:52 INFO - mozlog == 3.1 04:04:52 INFO - moznetwork == 0.27 04:04:52 INFO - mozprocess == 0.22 04:04:52 INFO - mozprofile == 0.28 04:04:52 INFO - mozrunner == 6.11 04:04:52 INFO - mozscreenshot == 0.1 04:04:52 INFO - mozsystemmonitor == 0.0 04:04:52 INFO - moztest == 0.7 04:04:52 INFO - mozversion == 1.4 04:04:52 INFO - psutil == 3.1.1 04:04:52 INFO - requests == 1.2.3 04:04:52 INFO - wsgiref == 0.1.2 04:04:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:04:52 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')]} 04:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:52 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')]} 04:04:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:52 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 0x10649ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f867bc66c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10633fd30>, '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 0x106163db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106336b20>, '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.lkf3N2gJav/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.wH88tey5bc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 04:04:52 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 04:04:52 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 04:04:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lkf3N2gJav/Render', 04:04:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:52 INFO - 'HOME': '/Users/cltbld', 04:04:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:52 INFO - 'LOGNAME': 'cltbld', 04:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:52 INFO - 'MOZ_NO_REMOTE': '1', 04:04:52 INFO - 'NO_EM_RESTART': '1', 04:04:52 INFO - 'PAGER': '/bin/cat', 04:04:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:52 INFO - 'PWD': '/builds/slave/test', 04:04:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:52 INFO - 'SHELL': '/bin/bash', 04:04:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wH88tey5bc/Listeners', 04:04:52 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 04:04:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:52 INFO - 'USER': 'cltbld', 04:04:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:52 INFO - 'XPC_FLAGS': '0x0', 04:04:52 INFO - 'XPC_SERVICE_NAME': '0', 04:04:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:53 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)) 04:04:53 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)) 04:04:53 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)) 04:04:53 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)) 04:04:53 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)) 04:04:53 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)) 04:04:53 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)) 04:04:53 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)) 04:04:53 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)) 04:04:53 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)) 04:04:53 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)) 04:04:53 INFO - Cleaning up... 04:04:53 INFO - Return code: 0 04:04:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10649ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f867bc66c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10633fd30>, '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 0x106163db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106336b20>, '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.lkf3N2gJav/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.wH88tey5bc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 04:04:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:04:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:04:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lkf3N2gJav/Render', 04:04:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:53 INFO - 'HOME': '/Users/cltbld', 04:04:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:53 INFO - 'LOGNAME': 'cltbld', 04:04:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:53 INFO - 'MOZ_NO_REMOTE': '1', 04:04:53 INFO - 'NO_EM_RESTART': '1', 04:04:53 INFO - 'PAGER': '/bin/cat', 04:04:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:53 INFO - 'PWD': '/builds/slave/test', 04:04:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:53 INFO - 'SHELL': '/bin/bash', 04:04:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wH88tey5bc/Listeners', 04:04:53 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 04:04:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:53 INFO - 'USER': 'cltbld', 04:04:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:53 INFO - 'XPC_FLAGS': '0x0', 04:04:53 INFO - 'XPC_SERVICE_NAME': '0', 04:04:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:53 INFO - Downloading/unpacking jsonschema 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:04:55 INFO - Downloading/unpacking functools32 (from jsonschema) 04:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:56 INFO - Downloading functools32-3.2.3-2.tar.gz 04:04:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:04:56 INFO - warning: no files found matching '*.txt' 04:04:56 INFO - no previously-included directories found matching 'build' 04:04:56 INFO - no previously-included directories found matching 'dist' 04:04:56 INFO - no previously-included directories found matching '.git*' 04:04:56 INFO - Installing collected packages: jsonschema, functools32 04:04:56 INFO - Running setup.py install for functools32 04:04:56 INFO - warning: no files found matching '*.txt' 04:04:56 INFO - no previously-included directories found matching 'build' 04:04:56 INFO - no previously-included directories found matching 'dist' 04:04:56 INFO - no previously-included directories found matching '.git*' 04:04:56 INFO - Successfully installed jsonschema functools32 04:04:56 INFO - Cleaning up... 04:04:56 INFO - Return code: 0 04:04:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10649ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f867bc66c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10633fd30>, '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 0x106163db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106336b20>, '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.lkf3N2gJav/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.wH88tey5bc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 04:04:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:04:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:04:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lkf3N2gJav/Render', 04:04:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:56 INFO - 'HOME': '/Users/cltbld', 04:04:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:56 INFO - 'LOGNAME': 'cltbld', 04:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:56 INFO - 'MOZ_NO_REMOTE': '1', 04:04:56 INFO - 'NO_EM_RESTART': '1', 04:04:56 INFO - 'PAGER': '/bin/cat', 04:04:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:56 INFO - 'PWD': '/builds/slave/test', 04:04:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:56 INFO - 'SHELL': '/bin/bash', 04:04:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wH88tey5bc/Listeners', 04:04:56 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 04:04:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:56 INFO - 'USER': 'cltbld', 04:04:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:56 INFO - 'XPC_FLAGS': '0x0', 04:04:56 INFO - 'XPC_SERVICE_NAME': '0', 04:04:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:56 INFO - Downloading/unpacking flake8 04:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:04:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:04:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:05:00 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 04:05:00 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 04:05:00 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 04:05:00 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 04:05:00 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 04:05:00 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 04:05:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:05:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:05:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:05:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:05:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:05:00 INFO - no previously-included directories found matching 'docs/_build' 04:05:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:05:01 INFO - Running setup.py install for pep8 04:05:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:05:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:05:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:05:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:05:01 INFO - no previously-included directories found matching 'docs/_build' 04:05:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:05:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:05:01 INFO - Cleaning up... 04:05:01 INFO - Return code: 0 04:05:01 INFO - Running post-action listener: _resource_record_post_action 04:05:01 INFO - Running post-action listener: _start_resource_monitoring 04:05:01 INFO - Starting resource monitoring. 04:05:01 INFO - ##### 04:05:01 INFO - ##### Finished create-virtualenv step (success) 04:05:01 INFO - ##### 04:05:01 INFO - ##### 04:05:01 INFO - ##### Running install step. 04:05:01 INFO - ##### 04:05:01 INFO - Running pre-action listener: _resource_record_pre_action 04:05:01 INFO - Running main action method: install 04:05:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:05:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:05:01 INFO - Reading from file tmpfile_stdout 04:05:01 INFO - Detecting whether we're running mozinstall >=1.0... 04:05:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:05:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:05:01 INFO - Reading from file tmpfile_stdout 04:05:01 INFO - Output received: 04:05:01 INFO - Usage: mozinstall [options] installer 04:05:01 INFO - Options: 04:05:01 INFO - -h, --help show this help message and exit 04:05:01 INFO - -d DEST, --destination=DEST 04:05:01 INFO - Directory to install application into. [default: 04:05:01 INFO - "/builds/slave/test"] 04:05:01 INFO - --app=APP Application being installed. [default: firefox] 04:05:01 INFO - mkdir: /builds/slave/test/build/application 04:05:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:05:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:05:35 INFO - Reading from file tmpfile_stdout 04:05:35 INFO - Output received: 04:05:35 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:05:35 INFO - Running post-action listener: _resource_record_post_action 04:05:35 INFO - ##### 04:05:35 INFO - ##### Finished install step (success) 04:05:35 INFO - ##### 04:05:35 INFO - ##### 04:05:35 INFO - ##### Running run-tests step. 04:05:35 INFO - ##### 04:05:35 INFO - Running pre-action listener: _resource_record_pre_action 04:05:35 INFO - Running main action method: run_tests 04:05:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:05:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:05:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:05:35 INFO - 2016-05-09 04:05:35.219 screenresolution[1978:10861] starting screenresolution argv=screenresolution get 04:05:35 INFO - 2016-05-09 04:05:35.222 screenresolution[1978:10861] Display 0: 1600x1200x32@60 04:05:35 INFO - 2016-05-09 04:05:35.228 screenresolution[1979:10863] starting screenresolution argv=screenresolution list 04:05:35 INFO - Available Modes on Display 0 04:05:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:05:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:05:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:05:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:05:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:05:35 INFO - Intel Iris: 04:05:35 INFO - Chipset Model: Intel Iris 04:05:35 INFO - Type: GPU 04:05:35 INFO - Bus: Built-In 04:05:35 INFO - VRAM (Dynamic, Max): 1536 MB 04:05:35 INFO - Vendor: Intel (0x8086) 04:05:35 INFO - Device ID: 0x0a2e 04:05:35 INFO - Revision ID: 0x0009 04:05:35 INFO - Displays: 04:05:35 INFO - Display: 04:05:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:05:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:05:35 INFO - Display Serial Number: 1600x1200 60 04:05:35 INFO - Main Display: Yes 04:05:35 INFO - Mirror: Off 04:05:35 INFO - Online: Yes 04:05:35 INFO - Rotation: Supported 04:05:35 INFO - Return code: 0 04:05:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:05:35 INFO - Python 2.7.3 04:05:35 INFO - Return code: 0 04:05:35 INFO - grabbing minidump binary from tooltool 04:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:35 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 0x10633fd30>, '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 0x106163db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106336b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:05:35 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 04:05:35 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 04:05:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:05:35 INFO - Return code: 0 04:05:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:05:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:05:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:05:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:05:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:05:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:05:36 INFO - Return code: 0 04:05:36 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/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0189', '--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 04:05:36 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/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0189 --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 04:05:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lkf3N2gJav/Render', 04:05:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:05:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:05:36 INFO - 'HOME': '/Users/cltbld', 04:05:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:05:36 INFO - 'LOGNAME': 'cltbld', 04:05:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:05:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:05:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:36 INFO - 'MOZ_NO_REMOTE': '1', 04:05:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:05:36 INFO - 'NO_EM_RESTART': '1', 04:05:36 INFO - 'PAGER': '/bin/cat', 04:05:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:05:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:36 INFO - 'PWD': '/builds/slave/test', 04:05:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:05:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:05:36 INFO - 'SHELL': '/bin/bash', 04:05:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wH88tey5bc/Listeners', 04:05:36 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 04:05:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:05:36 INFO - 'USER': 'cltbld', 04:05:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:05:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:05:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:36 INFO - 'XPC_FLAGS': '0x0', 04:05:36 INFO - 'XPC_SERVICE_NAME': '0', 04:05:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:05:36 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/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0189', '--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 04:05:36 INFO - mozversion application_buildid: 20160509021645 04:05:36 INFO - mozversion application_changeset: fd8bdef8ef752875c509141b3345ab9e722d6cec 04:05:36 INFO - mozversion application_display_name: Nightly 04:05:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:05:36 INFO - mozversion application_name: Firefox 04:05:36 INFO - mozversion application_remotingname: firefox 04:05:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:05:36 INFO - mozversion application_vendor: Mozilla 04:05:36 INFO - mozversion application_version: 49.0a1 04:05:36 INFO - mozversion platform_buildid: 20160509021645 04:05:36 INFO - mozversion platform_changeset: fd8bdef8ef752875c509141b3345ab9e722d6cec 04:05:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:05:36 INFO - mozversion platform_version: 49.0a1 04:05:36 INFO - using testdate: 1462791936 04:05:36 INFO - actual date: 1462791936 04:05:36 INFO - starting webserver on 'localhost:49395' 04:05:36 INFO - SUITE-START | Running 2 tests 04:05:36 INFO - TEST-START | dromaeo_css 04:05:36 INFO - operating with platform_type : mac_ 04:05:36 INFO - Initialising browser for dromaeo_css test... 04:05:36 INFO - TEST-INFO | started process 1997 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/tmpPsXmjD/profile http://localhost:49395/getInfo.html) 04:05:39 INFO - PROCESS | 1997 | __metrics Screen width/height:1600/1200 04:05:39 INFO - PROCESS | 1997 | colorDepth:24 04:05:39 INFO - PROCESS | 1997 | Browser inner width/height: 1024/689 04:05:39 INFO - PROCESS | 1997 | __metrics 04:05:39 ERROR - PROCESS | 1997 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 04:05:40 INFO - TEST-INFO | 1997: exit 0 04:05:40 INFO - Browser initialized. 04:05:40 INFO - Running cycle 1/1 for dromaeo_css test... 04:05:40 INFO - TEST-INFO | started process 2000 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/tmpPsXmjD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:05:52 INFO - PROCESS | 2000 | RSS: Main: 249823232 04:05:52 INFO - PROCESS | 2000 | 04:06:42 INFO - PROCESS | 2000 | 1462792002268 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] 04:08:52 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49395/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49395/tests/dromaeo/cssquery-ext.html) 04:08:53 INFO - PROCESS | 2000 | RSS: Main: 262160384 04:08:53 INFO - PROCESS | 2000 | 04:11:56 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49395/tests/dromaeo/cssquery-ext.html (next: http://localhost:49395/tests/dromaeo/cssquery-jquery.html) 04:11:56 INFO - PROCESS | 2000 | RSS: Main: 273752064 04:11:56 INFO - PROCESS | 2000 | 04:14:58 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49395/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49395/tests/dromaeo/cssquery-mootools.html) 04:14:59 INFO - PROCESS | 2000 | RSS: Main: 275705856 04:14:59 INFO - PROCESS | 2000 | 04:18:01 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49395/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49395/tests/dromaeo/cssquery-prototype.html) 04:18:01 INFO - PROCESS | 2000 | RSS: Main: 277372928 04:18:01 INFO - PROCESS | 2000 | 04:21:04 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49395/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49395/tests/dromaeo/cssquery-yui.html) 04:21:05 INFO - PROCESS | 2000 | RSS: Main: 280256512 04:21:05 INFO - PROCESS | 2000 | 04:24:07 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49395/tests/dromaeo/cssquery-yui.html (next: http://localhost:49395/tests/dromaeo/cssquery-dojo.html) 04:24:08 INFO - PROCESS | 2000 | RSS: Main: 281731072 04:24:08 INFO - PROCESS | 2000 | 04:24:08 INFO - PROCESS | 2000 | __start_tp_report 04:24:08 INFO - PROCESS | 2000 | _x_x_mozilla_page_load 04:24:08 INFO - PROCESS | 2000 | _x_x_mozilla_page_load_details 04:24:08 INFO - PROCESS | 2000 | |i|pagename|runs| 04:24:08 INFO - PROCESS | 2000 | |0;dojo.html;3424.400729872273;3457.979895930702;3466.8959931202057;3472.73954453416;3501.8774342898005;5777.884442311151;5793.246877905872;5869.413058694128;5891.970540147304;5900.498457631101;4465.977670111653;5681.147827825818;5799.159121927318;5806.506446952014;5830.271216097988;4120.340745480724;4350.912981740364;5219.086659834533;5234.816781412651;5346.224797404374;146.70916173420355;4876.587763358821;5037.59699224063;5205.37535495741;5308.734563271841;4308.913821723564;5221.425643179266;5283.920741188886;5291.074062039147;5317.335333083364;4354.325079612665;5288.391834938992;5304.6286759926825;5366.034113859504;5369.033573956686;4309.676774241944;4882.048000639877;5183.45573714762;5228.8692782680355;5230.320058392423;5559.193916882029;5695.914561281584;5707.4577915098;5718.628289161191;5761.48146666802;5113.642045056848;6192.752289908398;6197.845053873644;6213.844653883644;6252.906206406908;6101.572889897709;6117.644716737907;6135.84660383494;6161.815145545641;6193.969030154821;5961.314448838396;5961.940380596182;5973.402659734035;5990.341062483123;6002.639841609517;5876.236089308362;6118.314626315956;6146.139540464339;6336.524760642878;6348.111264422984;6120.78577249803;6131.816045518642;6132.569672417391;6138.754449821957;6146.78486252979;6117.96941015292;6184.81445556634;6208.751649934043;6232.781852635227;6258.186435763413;6112.321110680185;6140.846478838065;6176.505879529716;6183.227096612924;6198.907016394758;6143.815685529441;6151.231096112986;6184.381561843779;6185.103160041769;6186.783462578788;4923.310736496894;4953.554180123806;4955.306257124005;4955.430125535538;4972.105021096238;3719.590845007047;4379.824807007684;4393.978030109829;4469.173202957463;4503.054358584668;5826.359100498942;5930.466258036798;5959.821205363846;5961.8211453655595;5978.28260608721;6209.295478023957;6222.81331560054;6236.158118653923;6254.312025677172;6262.09199666055;5659.547236221092;5942.524598032147;5966.731497082642;6003.800881565731;6084.5436592255755;4684.110019096361;5349.973250133725;5502.99999999992;5510.834674959758;5546.140348246028;6018.638881667114;6252.9370007098905;6429.967850160813;6441.033844923205;6450.741970321134;6126.30393285589;6179.536534759821;6213.689315534296;6223.377662233922;6271.027990661455;6387.936120638734;6394.104825324552;6398.904016439664;6411.198600174978;6420.422162005442;6194.659293738888;6260.593061450991;6271.74913003493;6272.4982001440685;6280.528960328085;6128.625347140905;6158.722857471335;6166.136740856194;6219.191505104308;6263.248410190807;6096;6170.50635949132;6222.564420490522;6234.376562343729;6253.155823963707;5024.919642276928;6203.875922481616;6205.968970155301;6231.781887633911;6255.968720156552;5893.528517718658;5987.730552125252;5999.190109335358;6065.363136870565;6088.665123418077;5145.716985565829;6034.63792172471;6200.379962003944;6224.533160013108;6251.874962500816;5884.852878678067;6011.729472173675;6075.605085669417;6116.235470566179;6129.969350153221 04:24:08 INFO - PROCESS | 2000 | |1;ext.html;481.7831975610975;501.2706512025002;510.7573902396362;532.4967905329465;532.9706866122362;38129.80935095324;41109;41125.58874411255;41164.38253426194;41186.58813411865;40812.38781418274;41096.79451602738;41236;41650;41710.37434438486;9545.904540954589;9749.415035097916;9778;9795.853062204036;9810.46042467664;9657.179139773129;9677.806443871119;9703.369280996712;9725.756856078584;9729.464879431629;9703.369280996749;9714.65998690046;9751.853722194173;9759.951200244024;9802.607895684165;9683.951580242054;9691.854622180674;9695.22438204949;9716.465594392306;9751.024897510228;9575.329726919119;9629.422234665943;9661.323707340489;9666.661666841697;9669.226461883032;29214.561781573295;38384.04039899025;38403.039924001845;38479.422808657895;38959;2767.1836808141447;3045.2234680156416;3084;3398.9490157647656;3461.5846098468346;19248.90375548127;27498.587521187197;27620.723792762015;28091.859540702164;28743.712562874312;2586.702529209146;2649.576067829138;2676.2907829425217;2772.057500449857;2838.1201827433356;447370;450620.99999999674;450981;451800;453344;34932.12669683278;63900.68049659722;64048.67975660185;64456.67771661111;64456.67771661111;35508.82245588755;36345.81827090848;36695.81652091722;36767.81616091902;36809.631903681155;15318.234088295541;15394.23028848553;15486.767698484531;15536.92231538835;15539.922300388425;12594.559190428292;12631.242125472501;12775.808362874564;12963.546275880488;13080.28058456794;8141.877871831927;8178.550179740052;8185.508869467851;8223.177682231848;8228.341732661373;2981.373911478614;2987.2830520674884;3141.701538353853;3255.7790828439333;3417.128632198773;849.8993803025097;966.1015255812022;975.6975337645353;1069.4438891776388;1083.5936523803573;29636;29925.551116733266;30090.24774380658;30868.53697194544;31026.603802828926;949.188443880486;960.9375390599589;1085.0776839686202;1119.3955264157264;1171.8535183102113;12816.48734050646;14567.68890799833;15054.623634409227;15393.538193854203;15461.5361539154;607527.924720756;617689;663084;673708;680621;57096.71451642799;57317.71341143351;57397.71301143467;57771.422285777444;57973;1456.9635759106106;1462.1123281519128;1465.5017294119837;1470.522080323899;1480.7556753135827;28777.856110719313;28834.71165288404;29009.41981160407;29077.374462263902;29427.558586621646;41785.1642967145;49606.75196624138;50150.74924625354;50536;50558;600910;602188;607970;610169;617776;26248.737512625394;26426.867865660548;26612.733872661025;26616.866915665298;26678.333041674112;44058.33912491379;44325.11349773051;44492.55507445014;44555.77722111368;44567.77716111398;36767.08082297857;36826.63173368232;37309.440358395186;37365.252694946495;37546.68586599456;29792.70207297899;36477.27045459023;36915.63084369229;36976.445353319185;37373.6262637381;32204.83897580497;35576.46635300421;36238.4564231542;37081.81459092687;37232.44151337786;32210.033698989067;32602;33763;34929.30141397107;35205.82397087998;23064.538709225384;24248;24730;25130.37174070663;25184.11855585046 04:24:08 INFO - PROCESS | 2000 | |2;jquery.html;392.3408673428639;397.5706237263755;398.53172522286314;399.7441637352093;417.57824597156883;19643.214271429126;21015;21018.789812101873;21063.68404473934;21991.230306939262;20434.69347959778;20744;21187.834669093234;21453.249136280232;21492.247771328006;5707.77168913243;5844.678542680151;5847.006008978463;5851.356350801409;5897.056470964647;5642.4357564243655;5884.499817515516;5898.115282707586;5914.349421563625;6010.849728756794;5760.740766665489;5796.217510636074;5844.1818145459665;5848.766049358021;5849.7660093596205;4770.189067858472;5823.854403639901;5835.241418615574;5861.032929566616;5874.97062514689;5105.259737338102;5111.821086262;5116.437191908887;5142.331496905415;5184.818531351422;25384.619230711553;25691.48617027649;25928.22215333543;26565;26716.465670686674;2164.9025793839314;2204.5370472200857;2306.5271619318;2424.097083789217;2499.3251822008137;8496.915030849674;9530;10024.147947424477;14893.77659335111;15541.456049038343;1424.6936908564708;1675.5392267126515;1688.4934519644057;1706.2251879381665;1812.9818701812944;105290.47354763254;126012.36993814973;132747;133247;135809;11768.35274059935;11900.107491938139;11954;11974.940125299318;12212.511499539918;15040.623984400478;15189.392424302903;15416.46042388511;15503.922480387526;15529;7431.479796414307;7464.880267959849;8893.866592001124;8955.41789783662;9022.458652480873;7238.963805180941;8550.572471376407;8829.470231786114;8834.86747698785;8839.46963182211;4675.7895894684825;4750.596199323097;4787.8563643090765;4811.663183577186;4849.854504364875;1708.4959936818668;1952.4045166224437;2016.637005339053;2019.7475315585552;2049.4261606750133;901.8241442918568;963.5326866469757;998.7602975285879;1049.9632512862013;1084.1922767538076;19859.205631774566;20133.09401076955;20614.484637884172;20671.17315307401;21095.578088438146;930.0234753508789;956.2588993529931;978.6476868327538;980.5342462330478;1050.4432650695144;7407.555546667109;10920;10973.945130274456;10979.396133212591;11010.724731881606;595018;602378;607126;611576;611976;70956.64521677358;128277;128900;132776.68058298618;133622;1009.5860697114148;1009.6819501856892;1011.7521207304258;1045.5190612318268;1062.511244827388;18105;18193.45419637413;18410;18446;18467.16897739578;49359.50640493549;49939.635819406336;49955;50097;50668.47994560169;70381.64809175921;71171.64414177896;75240.24759752551;75759.62120189363;82407.5879620622;7386.519876208029;8303.626336814737;8310.750677479686;8405.95797021011;8451.66193352259;11772.70568235801;12856.100072995174;12950.028747844139;13220.537281195113;13362.799558006443;11178.323251512338;11227.21409501327;11233.775324493628;11456.599019034295;11592.594259200887;10768.46157692128;11130.610428634958;11139.053180479426;11283.266587672104;11517.078633709116;11422.600208992646;11533.942330288295;11639.76720465603;11831.82252266234;11890.643280701594;8250.216229458192;8261.586920653823;8369.204925532065;8392.244697977212;8573.442726222776;8509.149085091442;10957.287776294515;11358.659240222807;11504;11701.122415819018 04:24:08 INFO - PROCESS | 2000 | |3;mootools.html;1593.960150996225;1620.4571468558033;1822.161805569438;1858.9535261618457;1923.4325873867208;6985.650717464126;7894.605269736505;8455.915440845589;8971.416857904233;9001.774955626113;8571.828563428728;8616.827663446727;8741.912580874205;8769.123087691227;8787.428817126882;2453.227233421471;2483.9379015524664;2485.763852434025;2487.3905893056226;2490.56415127352;2418.117387153685;2478.293686299405;2481.888315025828;2482.379405148713;2489.3029951613485;2458.9016439342404;2460.015993602555;2460.1512478194995;2490.713567939683;2494.0896572750908;1841.742156098154;2208.8343374246915;2438.5854404751144;2444.327809852287;2454.275988583372;2395.916142934989;2437.9146729864547;2438.4025913651267;2444.669969554105;2447.5716749568933;6546.6072035677535;7442.702291908317;8712.693096035582;8780.25367843734;8799.516026618534;4578.2903649934315;5318.069337865858;5446.618736688433;5457.836264912059;5488.368837583649;2628.5925681519393;3028.0158948341877;3517.9296414071573;3633.727470439701;3660.798656073915;1027.5170669785189;1036.8444733289991;1038.2005855491304;1040.921930855189;1071.791000754853;11338.036266917323;11475.254108482923;11483.712907177303;11509;11527;4272.4873015237745;4311.48262208537;4610.847288177955;4674.924767303539;4975.154223781966;9926.305158638826;9928.900710992797;9932.751681207883;9948.154406875497;9959.800803984024;5320.627556071038;5365.731713414314;5425.023495770799;5446.319210098738;5457.181422786534;4452.0873220989615;4774.427068751772;4924.630652701062;4942.481039490874;4980.551750342486;4074.5517993020744;4086.521939772399;4114.773687447219;4163.916721665611;4167.812448439828;1174.7591743692522;1365.5766712319212;1380.3857283508944;1384.7092110656874;1385.2658091211674;916.1983264643437;919.4161707315902;920.3373571028849;944.1125342178331;968.1528662420383;5851.063829787214;5911.024680927599;6016.909746353808;6031.366706495843;6056.939430605637;403.8344278845659;453.60989548987845;460.2038473440966;469.94595621503964;477.22451017097217;3927.9410808837893;3979.7811120388656;4054.6350828425584;4056.9391459128137;4061.5532291447917;9337.859932101024;9881.25890558211;10584.682459526226;10649.574017039231;10712.410817404962;8936.8659470108;10310;10366.378017318984;10562.788744225227;10746.194035447374;6920.719666861647;8053.83892322162;8107.1892810718455;8129.390295727844;8196.877046844183;5158.303629010185;5841.32824725145;5913.615614985012;5926.140709596998;5994.790182343597;9892.653757118467;9944.204463643036;9952.303338766216;9959.651412200537;10050.949745251228;9866.654667086617;10041.698749037541;10110.949445252727;10112.797744045225;10205.132563732166;6895;7314.341709246193;7496.25037496246;7545.056867891513;7578.317951384402;8369.748907532783;8401.579921004048;8402.87395689053;8484.321254299517;8493.915060849313;7408.481406301507;7517.661705223388;7575.734849280248;7631.122420921443;7670.616469176631;7264.89102663471;7285.307895749896;7296.671649775879;7376.889346659912;7379.262073792578;7049.506534542533;7066.505344625827;7082.185548661764;7111.893321600077;7137.250588688113;4353.891152721208;4804.879878002938;4954.950450495449;4990.50094990498;4994.650374473752;4948.588669657402;4949.678270912379;4972.825951091694;5048.242763585492;5198.272241886063 04:24:08 INFO - PROCESS | 2000 | |4;prototype.html;314.2897052660987;321.3588890164122;326.9504889305329;328.7255141956466;331.0928057123481;4407.316865885785;4774.856754297368;5416.377116631588;5488.012157811592;5506.449355064497;5391.921615676871;5401.918971215425;5424.701641409721;5446.210299506569;5477.945220547794;3711.5917249102577;3955.782431966241;4167.999680076775;4182.33082706767;4206.476114331392;3611.5305010348616;4047.615476529725;4052.412400201969;4203.087595144218;4217;4081.163361510898;4112.465379500661;4129.159881310396;4133.462649855514;4182.205380977604;3568;3979.5224573051128;4189.22499337622;4205.894852628679;4214.262504061792;3068.539719042139;3368.747343949189;3404.897853064412;3670.926581468356;3673.5775385830702;4234.640055595278;4890.70655760652;5130.922506273687;5201.55786758126;5303.602229832778;4024.6718582867875;4079.5930401063515;4608.833848091392;4637.721736695776;4677.532246775329;4993.6005119590345;5195.636305458619;5669.348024977139;5703.3441154267375;5774.82675519735;3612.060864175307;3852.460655508231;3900.4734360861203;3906.1211227473877;3924.352481840493;4527.4114365132655;5018.347614810088;5843.883122337529;5982.641041537521;6050.45545900871;3922.941155882664;3950.7234493585174;3953.7545673112877;3982.422548730418;4004.4794176756836;3423.691867731916;3874.9225015499533;3965.237623420723;4039.979800100981;4060.8020633913065;4606;4650.8140424191615;4672.813087476463;4703.459102203222;4704.553632111283;4674.672772905932;4684.531546845288;4715.363425937523;5320.76056577455;5735.283089613798;1101.5869049106584;1183.3077649575096;1193.498730533178;1272.4719241514854;1312.330711337206;843.5866425451485;865.4980111535294;869.6956065377068;880.5509190312987;891;4450.6884518083425;4647.790849411785;5014.423341315723;5023.321851550067;5053.36832895888;4447.9293605289995;4916.06594746997;5297.708626025606;5328.17413300939;5598.193228604507;4107.199096176217;4127;4647.465541462708;4918.950250844499;4990.50094990498;2642.7357264273805;2722.664735698793;2727.440874620698;2931.721486458783;2932.6627437844495;5261.710605916712;5714.571307194426;5772.826815195551;5779.248697669276;5836.015754643442;4877.95122048775;5436;5561.721913904369;5563.5271001964475;5881.323647780475;4850.908545577287;5581.916271255935;5806.44838740319;5857.648541087548;5863.882722345529;5029.698218106925;5223.92164117531;5541.113421852484;5555;5596.664200148004;5181.5077567631015;5199.582194279678;5217.165253559412;5532.861678458071;5605.655616896937;5137.357830271216;5353.892922141613;5494.011078005998;5582.916256256078;5801.1878337033695;3264.6941223510785;3592.8383222754514;3623.130448692242;3626.6192049835445;3742.6631603155847;4914.70511769295;4953.925691114709;5109.718965456936;5226.686398816083;5750.367459579526;5592.468715472024;5718.313802343579;5723.599348045597;5745.253117094751;5745.9425405745405;5678.829635110953;5711.286089238845;5754.834840837606;5792.82621521355;5809.269643267658;4988.206604301603;5421.40364559906;5579.525740311957;5675.7445914933105;5695.715214239354;4645.3032045193495;4790.209615413557;4886.166023706171;5512.200730894078;5608.906263278622;5050.393952725696;5636.436356364331;5641.210230567806;5655.455045229745;5717.542596592346 04:24:08 INFO - PROCESS | 2000 | |5;yui.html;584.7456356484927;618.8050764009337;634.3879992454854;659.633903183733;727.8289601943542;13212.471501139955;15033.323500442506;15252.618684532878;15301.617459563517;15336.846631533681;13965.022448428614;13999;14070.22613756243;14098.365573549188;14151.999999999975;703.4688809948507;705.4990956420947;830.1325115254574;879.0286733159862;910.7905181808155;897.3494216692878;901.7700486375965;902.1339514066472;908.604756930734;915.0392088307251;934.2432629570036;936.3866667332908;969.2633598465181;974.1670871404953;976.9658061967832;924.7595625137445;951.600327862296;968.5883499512679;969.8836139663285;972.8248915195262;703.8768215562257;711.6761873347615;723.616483263871;727.3671905442299;731.3746746531746;14704.191269480174;14717.190554519497;14731.558053258419;14818.851811481854;14928.776068358984;11533.8466153384;12199.817002744965;12905.225686458749;13040.347982600926;13280.867191328156;8445.535495547743;9925.70222893307;10251.58993640261;10370.429626370622;10451.954804519562;3523.4324153794983;3543.2382037861985;3566.982165089184;3574.088607405095;3635.4546817977252;81294.18705812925;81890.77163842547;84234.73647895287;84484.57757711172;84759.5762021186;9362.578683959102;9576.90423095774;9594.42433453981;9605.855912161323;9814.754631134136;22396.664050039264;22560.323190304316;22983.655245171336;22989.88505057464;23040.308790736304;7563.168051514329;7592.202818704067;7613.010308659839;7676.232376762279;7885.369170466349;3682.3187710273687;3894.4811523505855;3988.501437320335;4011.659008984269;4081.3469844824685;3513.6135025147214;3626.9093272668392;3627.3289441453417;3628.9818550907075;3634.982204982609;627.212847875922;630.8044506203091;634.7365843175123;642.6722371590522;651.4072194303161;507.6620279709888;557.2031994248183;568.573569822633;588.6379876376084;594.4768603628866;7916.406269529808;7956.562389068657;8116.8782468263025;8245.257926786619;8266.545340006358;514.2902794144057;585.3911931591183;585.809611876142;587.4918195760722;596.9432903874125;3848.3650197717625;3876.1472476055224;3882.1847412043785;3911.1395492991496;3912.6478616924046;90905;91064;92382.30470781094;93181.53409232911;94889.5255523718;81004.59497702592;81126;81222;82409.58795205985;82704.58647706723;66038.00942985955;69560;69719.65140174267;69828.65085674539;70273.64863175753;7322.48742588035;7543.962280188564;7750.213260566899;7760.30157285847;7802.375809935305;38168.473261069244;40084.398734019596;43447.13105737931;43916.560834391246;44067.55932440634;42879.142417150855;61185.77628447495;62033.06950395838;62409.375906240355;62476.68761656163;10238.948805255926;10366.585336586451;10769.892301076889;10806.729831754268;11019.338839669645;11273.098152147972;11380.94309528447;11502.53989840397;11617.47721352558;11865.940670296593;10192.439415832201;10324.122449591869;10415.479226038819;10438.112760415146;10627.840582391425;10410.323328983592;10500.947495262475;10559.577616895238;10639.202059845697;10693.9465302673;10234.795304093728;10339.431331276852;10386.480675966322;10478.109360704426;10600.46997650099;8840.557972101498;9049.079754601342;9182.540872956459;9415.482148481899;9636;8820.382573219813;8960.775980600538;9018.413803102778;9020.684276050306;9289.535523223947 04:24:08 INFO - PROCESS | 2000 | __end_tp_report 04:24:08 INFO - PROCESS | 2000 | __start_cc_report 04:24:08 INFO - PROCESS | 2000 | _x_x_mozilla_cycle_collect,414 04:24:08 INFO - PROCESS | 2000 | __end_cc_report 04:24:08 INFO - PROCESS | 2000 | __startTimestamp1462793048044__endTimestamp 04:24:08 INFO - PROCESS | 2000 | 04:24:08 INFO - PROCESS | 2000 | ------- Summary: start ------- 04:24:08 INFO - PROCESS | 2000 | Number of tests: 6 04:24:08 INFO - PROCESS | 2000 | 04:24:08 INFO - PROCESS | 2000 | [#0] dojo.html Cycles:165 Average:5692.51 Median:6011.73 stddev:822.04 (13.7%) stddev-sans-first:805.08 04:24:08 INFO - PROCESS | 2000 | Values: 3424.4 3458.0 3466.9 3472.7 3501.9 5777.9 5793.2 5869.4 5892.0 5900.5 4466.0 5681.1 5799.2 5806.5 5830.3 4120.3 4350.9 5219.1 5234.8 5346.2 146.7 4876.6 5037.6 5205.4 5308.7 4308.9 5221.4 5283.9 5291.1 5317.3 4354.3 5288.4 5304.6 5366.0 5369.0 4309.7 4882.0 5183.5 5228.9 5230.3 5559.2 5695.9 5707.5 5718.6 5761.5 5113.6 6192.8 6197.8 6213.8 6252.9 6101.6 6117.6 6135.8 6161.8 6194.0 5961.3 5961.9 5973.4 5990.3 6002.6 5876.2 6118.3 6146.1 6336.5 6348.1 6120.8 6131.8 6132.6 6138.8 6146.8 6118.0 6184.8 6208.8 6232.8 6258.2 6112.3 6140.8 6176.5 6183.2 6198.9 6143.8 6151.2 6184.4 6185.1 6186.8 4923.3 4953.6 4955.3 4955.4 4972.1 3719.6 4379.8 4394.0 4469.2 4503.1 5826.4 5930.5 5959.8 5961.8 5978.3 6209.3 6222.8 6236.2 6254.3 6262.1 5659.5 5942.5 5966.7 6003.8 6084.5 4684.1 5350.0 5503.0 5510.8 5546.1 6018.6 6252.9 6430.0 6441.0 6450.7 6126.3 6179.5 6213.7 6223.4 6271.0 6387.9 6394.1 6398.9 6411.2 6420.4 6194.7 6260.6 6271.7 6272.5 6280.5 6128.6 6158.7 6166.1 6219.2 6263.2 6096.0 6170.5 6222.6 6234.4 6253.2 5024.9 6203.9 6206.0 6231.8 6256.0 5893.5 5987.7 5999.2 6065.4 6088.7 5145.7 6034.6 6200.4 6224.5 6251.9 5884.9 6011.7 6075.6 6116.2 6130.0 04:24:08 INFO - PROCESS | 2000 | 04:24:08 INFO - PROCESS | 2000 | [#1] ext.html Cycles:180 Average:68395.32 Median:37460.16 stddev:154362.52 (412.1%) stddev-sans-first:154711.33 04:24:08 INFO - PROCESS | 2000 | Values: 481.8 501.3 510.8 532.5 533.0 38129.8 41109.0 41125.6 41164.4 41186.6 40812.4 41096.8 41236.0 41650.0 41710.4 9545.9 9749.4 9778.0 9795.9 9810.5 9657.2 9677.8 9703.4 9725.8 9729.5 9703.4 9714.7 9751.9 9760.0 9802.6 9684.0 9691.9 9695.2 9716.5 9751.0 9575.3 9629.4 9661.3 9666.7 9669.2 29214.6 38384.0 38403.0 38479.4 38959.0 2767.2 3045.2 3084.0 3398.9 3461.6 19248.9 27498.6 27620.7 28091.9 28743.7 2586.7 2649.6 2676.3 2772.1 2838.1 447370.0 450621.0 450981.0 451800.0 453344.0 34932.1 63900.7 64048.7 64456.7 64456.7 35508.8 36345.8 36695.8 36767.8 36809.6 15318.2 15394.2 15486.8 15536.9 15539.9 12594.6 12631.2 12775.8 12963.5 13080.3 8141.9 8178.6 8185.5 8223.2 8228.3 2981.4 2987.3 3141.7 3255.8 3417.1 849.9 966.1 975.7 1069.4 1083.6 29636.0 29925.6 30090.2 30868.5 31026.6 949.2 960.9 1085.1 1119.4 1171.9 12816.5 14567.7 15054.6 15393.5 15461.5 607527.9 617689.0 663084.0 673708.0 680621.0 57096.7 57317.7 57397.7 57771.4 57973.0 1457.0 1462.1 1465.5 1470.5 1480.8 28777.9 28834.7 29009.4 29077.4 29427.6 41785.2 49606.8 50150.7 50536.0 50558.0 600910.0 602188.0 607970.0 610169.0 617776.0 26248.7 26426.9 26612.7 26616.9 26678.3 44058.3 44325.1 44492.6 44555.8 44567.8 36767.1 36826.6 37309.4 37365.3 37546.7 29792.7 36477.3 36915.6 36976.4 37373.6 32204.8 35576.5 36238.5 37081.8 37232.4 32210.0 32602.0 33763.0 34929.3 35205.8 23064.5 24248.0 24730.0 25130.4 25184.1 04:24:08 INFO - PROCESS | 2000 | 04:24:08 INFO - PROCESS | 2000 | [#2] jquery.html Cycles:180 Average:35161.57 Median:2365.31 stddev:101030.73 (4271.3%) stddev-sans-first:101280.42 04:24:08 INFO - PROCESS | 2000 | Values: 392.3 397.6 398.5 399.7 417.6 19643.2 21015.0 21018.8 21063.7 21991.2 20434.7 20744.0 21187.8 21453.2 21492.2 5707.8 5844.7 5847.0 5851.4 5897.1 5642.4 5884.5 5898.1 5914.3 6010.8 5760.7 5796.2 5844.2 5848.8 5849.8 4770.2 5823.9 5835.2 5861.0 5875.0 5105.3 5111.8 5116.4 5142.3 5184.8 25384.6 25691.5 25928.2 26565.0 26716.5 2164.9 2204.5 2306.5 2424.1 2499.3 8496.9 9530.0 10024.1 14893.8 15541.5 1424.7 1675.5 1688.5 1706.2 1813.0 105290.5 126012.4 132747.0 133247.0 135809.0 11768.4 11900.1 11954.0 11974.9 12212.5 15040.6 15189.4 15416.5 15503.9 15529.0 7431.5 7464.9 8893.9 8955.4 9022.5 7239.0 8550.6 8829.5 8834.9 8839.5 4675.8 4750.6 4787.9 4811.7 4849.9 1708.5 1952.4 2016.6 2019.7 2049.4 901.8 963.5 998.8 1050.0 1084.2 19859.2 20133.1 20614.5 20671.2 21095.6 930.0 956.3 978.6 980.5 1050.4 7407.6 10920.0 10973.9 10979.4 11010.7 595018.0 602378.0 607126.0 611576.0 611976.0 70956.6 128277.0 128900.0 132776.7 133622.0 1009.6 1009.7 1011.8 1045.5 1062.5 18105.0 18193.5 18410.0 18446.0 18467.2 49359.5 49939.6 49955.0 50097.0 50668.5 70381.6 71171.6 75240.2 75759.6 82407.6 7386.5 8303.6 8310.8 8406.0 8451.7 11772.7 12856.1 12950.0 13220.5 13362.8 11178.3 11227.2 11233.8 11456.6 11592.6 10768.5 11130.6 11139.1 11283.3 11517.1 11422.6 11533.9 11639.8 11831.8 11890.6 8250.2 8261.6 8369.2 8392.2 8573.4 8509.1 10957.3 11358.7 11504.0 11701.1 04:24:08 INFO - PROCESS | 2000 | 04:24:08 INFO - PROCESS | 2000 | [#3] mootools.html Cycles:180 Average:5645.55 Median:4963.89 stddev:3131.35 (63.1%) stddev-sans-first:3125.33 04:24:08 INFO - PROCESS | 2000 | Values: 1594.0 1620.5 1822.2 1859.0 1923.4 6985.7 7894.6 8455.9 8971.4 9001.8 8571.8 8616.8 8741.9 8769.1 8787.4 2453.2 2483.9 2485.8 2487.4 2490.6 2418.1 2478.3 2481.9 2482.4 2489.3 2458.9 2460.0 2460.2 2490.7 2494.1 1841.7 2208.8 2438.6 2444.3 2454.3 2395.9 2437.9 2438.4 2444.7 2447.6 6546.6 7442.7 8712.7 8780.3 8799.5 4578.3 5318.1 5446.6 5457.8 5488.4 2628.6 3028.0 3517.9 3633.7 3660.8 1027.5 1036.8 1038.2 1040.9 1071.8 11338.0 11475.3 11483.7 11509.0 11527.0 4272.5 4311.5 4610.8 4674.9 4975.2 9926.3 9928.9 9932.8 9948.2 9959.8 5320.6 5365.7 5425.0 5446.3 5457.2 4452.1 4774.4 4924.6 4942.5 4980.6 4074.6 4086.5 4114.8 4163.9 4167.8 1174.8 1365.6 1380.4 1384.7 1385.3 916.2 919.4 920.3 944.1 968.2 5851.1 5911.0 6016.9 6031.4 6056.9 403.8 453.6 460.2 469.9 477.2 3927.9 3979.8 4054.6 4056.9 4061.6 9337.9 9881.3 10584.7 10649.6 10712.4 8936.9 10310.0 10366.4 10562.8 10746.2 6920.7 8053.8 8107.2 8129.4 8196.9 5158.3 5841.3 5913.6 5926.1 5994.8 9892.7 9944.2 9952.3 9959.7 10050.9 9866.7 10041.7 10110.9 10112.8 10205.1 6895.0 7314.3 7496.3 7545.1 7578.3 8369.7 8401.6 8402.9 8484.3 8493.9 7408.5 7517.7 7575.7 7631.1 7670.6 7264.9 7285.3 7296.7 7376.9 7379.3 7049.5 7066.5 7082.2 7111.9 7137.3 4353.9 4804.9 4955.0 4990.5 4994.7 4948.6 4949.7 4972.8 5048.2 5198.3 04:24:08 INFO - PROCESS | 2000 | 04:24:08 INFO - PROCESS | 2000 | [#4] prototype.html Cycles:180 Average:4468.38 Median:4917.51 stddev:1365.57 (27.8%) stddev-sans-first:1333.33 04:24:08 INFO - PROCESS | 2000 | Values: 314.3 321.4 327.0 328.7 331.1 4407.3 4774.9 5416.4 5488.0 5506.4 5391.9 5401.9 5424.7 5446.2 5477.9 3711.6 3955.8 4168.0 4182.3 4206.5 3611.5 4047.6 4052.4 4203.1 4217.0 4081.2 4112.5 4129.2 4133.5 4182.2 3568.0 3979.5 4189.2 4205.9 4214.3 3068.5 3368.7 3404.9 3670.9 3673.6 4234.6 4890.7 5130.9 5201.6 5303.6 4024.7 4079.6 4608.8 4637.7 4677.5 4993.6 5195.6 5669.3 5703.3 5774.8 3612.1 3852.5 3900.5 3906.1 3924.4 4527.4 5018.3 5843.9 5982.6 6050.5 3922.9 3950.7 3953.8 3982.4 4004.5 3423.7 3874.9 3965.2 4040.0 4060.8 4606.0 4650.8 4672.8 4703.5 4704.6 4674.7 4684.5 4715.4 5320.8 5735.3 1101.6 1183.3 1193.5 1272.5 1312.3 843.6 865.5 869.7 880.6 891.0 4450.7 4647.8 5014.4 5023.3 5053.4 4447.9 4916.1 5297.7 5328.2 5598.2 4107.2 4127.0 4647.5 4919.0 4990.5 2642.7 2722.7 2727.4 2931.7 2932.7 5261.7 5714.6 5772.8 5779.2 5836.0 4878.0 5436.0 5561.7 5563.5 5881.3 4850.9 5581.9 5806.4 5857.6 5863.9 5029.7 5223.9 5541.1 5555.0 5596.7 5181.5 5199.6 5217.2 5532.9 5605.7 5137.4 5353.9 5494.0 5582.9 5801.2 3264.7 3592.8 3623.1 3626.6 3742.7 4914.7 4953.9 5109.7 5226.7 5750.4 5592.5 5718.3 5723.6 5745.3 5745.9 5678.8 5711.3 5754.8 5792.8 5809.3 4988.2 5421.4 5579.5 5675.7 5695.7 4645.3 4790.2 4886.2 5512.2 5608.9 5050.4 5636.4 5641.2 5655.5 5717.5 04:24:08 INFO - PROCESS | 2000 | 04:24:08 INFO - PROCESS | 2000 | [#5] yui.html Cycles:180 Average:17838.97 Median:30902.29 stddev:25454.49 (82.4%) stddev-sans-first:25492.93 04:24:08 INFO - PROCESS | 2000 | Values: 584.7 618.8 634.4 659.6 727.8 13212.5 15033.3 15252.6 15301.6 15336.8 13965.0 13999.0 14070.2 14098.4 14152.0 703.5 705.5 830.1 879.0 910.8 897.3 901.8 902.1 908.6 915.0 934.2 936.4 969.3 974.2 977.0 924.8 951.6 968.6 969.9 972.8 703.9 711.7 723.6 727.4 731.4 14704.2 14717.2 14731.6 14818.9 14928.8 11533.8 12199.8 12905.2 13040.3 13280.9 8445.5 9925.7 10251.6 10370.4 10452.0 3523.4 3543.2 3567.0 3574.1 3635.5 81294.2 81890.8 84234.7 84484.6 84759.6 9362.6 9576.9 9594.4 9605.9 9814.8 22396.7 22560.3 22983.7 22989.9 23040.3 7563.2 7592.2 7613.0 7676.2 7885.4 3682.3 3894.5 3988.5 4011.7 4081.3 3513.6 3626.9 3627.3 3629.0 3635.0 627.2 630.8 634.7 642.7 651.4 507.7 557.2 568.6 588.6 594.5 7916.4 7956.6 8116.9 8245.3 8266.5 514.3 585.4 585.8 587.5 596.9 3848.4 3876.1 3882.2 3911.1 3912.6 90905.0 91064.0 92382.3 93181.5 94889.5 81004.6 81126.0 81222.0 82409.6 82704.6 66038.0 69560.0 69719.7 69828.7 70273.6 7322.5 7544.0 7750.2 7760.3 7802.4 38168.5 40084.4 43447.1 43916.6 44067.6 42879.1 61185.8 62033.1 62409.4 62476.7 10238.9 10366.6 10769.9 10806.7 11019.3 11273.1 11380.9 11502.5 11617.5 11865.9 10192.4 10324.1 10415.5 10438.1 10627.8 10410.3 10500.9 10559.6 10639.2 10693.9 10234.8 10339.4 10386.5 10478.1 10600.5 8840.6 9049.1 9182.5 9415.5 9636.0 8820.4 8960.8 9018.4 9020.7 9289.5 04:24:08 INFO - PROCESS | 2000 | -------- Summary: end -------- 04:24:08 INFO - PROCESS | 2000 | 04:24:08 INFO - TEST-INFO | 2000: exit 0 04:24:08 INFO - TEST-OK | dromaeo_css | took 1111796ms 04:24:08 INFO - TEST-START | kraken 04:24:08 INFO - operating with platform_type : mac_ 04:24:08 INFO - Initialising browser for kraken test... 04:24:08 INFO - TEST-INFO | started process 2007 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/tmpB9DlHJ/profile http://localhost:49395/getInfo.html) 04:24:11 INFO - PROCESS | 2007 | __metrics Screen width/height:1600/1200 04:24:11 INFO - PROCESS | 2007 | colorDepth:24 04:24:11 INFO - PROCESS | 2007 | Browser inner width/height: 1024/689 04:24:11 INFO - PROCESS | 2007 | __metrics 04:24:11 ERROR - PROCESS | 2007 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 04:24:12 INFO - TEST-INFO | 2007: exit 0 04:24:12 INFO - Browser initialized. 04:24:12 INFO - Running cycle 1/1 for kraken test... 04:24:12 INFO - TEST-INFO | started process 2010 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/tmpB9DlHJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:24:24 INFO - PROCESS | 2010 | RSS: Main: 250118144 04:24:24 INFO - PROCESS | 2010 | 04:24:26 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49395/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49395/tests/kraken/driver.html?testName=audio-beat-detection) 04:24:27 INFO - PROCESS | 2010 | RSS: Main: 261812224 04:24:27 INFO - PROCESS | 2010 | 04:24:30 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49395/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49395/tests/kraken/driver.html?testName=audio-dft) 04:24:31 INFO - PROCESS | 2010 | RSS: Main: 267018240 04:24:31 INFO - PROCESS | 2010 | 04:24:34 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49395/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49395/tests/kraken/driver.html?testName=audio-fft) 04:24:35 INFO - PROCESS | 2010 | RSS: Main: 267341824 04:24:35 INFO - PROCESS | 2010 | 04:24:37 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49395/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49395/tests/kraken/driver.html?testName=audio-oscillator) 04:24:37 INFO - PROCESS | 2010 | RSS: Main: 267493376 04:24:37 INFO - PROCESS | 2010 | 04:24:39 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49395/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49395/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:24:40 INFO - PROCESS | 2010 | RSS: Main: 267997184 04:24:40 INFO - PROCESS | 2010 | 04:24:43 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49395/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49395/tests/kraken/driver.html?testName=imaging-darkroom) 04:24:44 INFO - PROCESS | 2010 | RSS: Main: 268742656 04:24:44 INFO - PROCESS | 2010 | 04:24:46 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49395/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49395/tests/kraken/driver.html?testName=imaging-desaturate) 04:24:47 INFO - PROCESS | 2010 | RSS: Main: 268824576 04:24:47 INFO - PROCESS | 2010 | 04:24:50 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49395/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49395/tests/kraken/driver.html?testName=json-parse-financial) 04:24:51 INFO - PROCESS | 2010 | RSS: Main: 269209600 04:24:51 INFO - PROCESS | 2010 | 04:24:52 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49395/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49395/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:24:53 INFO - PROCESS | 2010 | RSS: Main: 267919360 04:24:53 INFO - PROCESS | 2010 | 04:24:55 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49395/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49395/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:24:56 INFO - PROCESS | 2010 | RSS: Main: 267997184 04:24:56 INFO - PROCESS | 2010 | 04:24:58 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49395/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49395/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:24:59 INFO - PROCESS | 2010 | RSS: Main: 268263424 04:24:59 INFO - PROCESS | 2010 | 04:25:01 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49395/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49395/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:25:02 INFO - PROCESS | 2010 | RSS: Main: 268443648 04:25:02 INFO - PROCESS | 2010 | 04:25:05 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49395/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49395/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:25:06 INFO - PROCESS | 2010 | RSS: Main: 268722176 04:25:06 INFO - PROCESS | 2010 | 04:25:07 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49395/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49395/tests/kraken/driver.html?testName=ai-astar) 04:25:08 INFO - PROCESS | 2010 | RSS: Main: 270155776 04:25:08 INFO - PROCESS | 2010 | 04:25:08 INFO - PROCESS | 2010 | __start_tp_report 04:25:08 INFO - PROCESS | 2010 | _x_x_mozilla_page_load 04:25:08 INFO - PROCESS | 2010 | _x_x_mozilla_page_load_details 04:25:08 INFO - PROCESS | 2010 | |i|pagename|runs| 04:25:08 INFO - PROCESS | 2010 | |0;ai-astar;111;115;109;117;116;117;110;115;115;115 04:25:08 INFO - PROCESS | 2010 | |1;audio-beat-detection;154;120;145;167;120;144;151;147;198;127 04:25:08 INFO - PROCESS | 2010 | |2;audio-dft;198;196;197;215;252;276;259;192;197;225 04:25:08 INFO - PROCESS | 2010 | |3;audio-fft;73;83;75;147;83;80;83;73;131;59 04:25:08 INFO - PROCESS | 2010 | |4;audio-oscillator;81;98;133;71;75;95;121;67;99;159 04:25:08 INFO - PROCESS | 2010 | |5;imaging-gaussian-blur;88;87;88;86;88;85;89;86;102;130 04:25:08 INFO - PROCESS | 2010 | |6;imaging-darkroom;94;95;94;95;96;104;95;96;96;132 04:25:08 INFO - PROCESS | 2010 | |7;imaging-desaturate;83;83;76;131;151;87;141;142;91;128 04:25:08 INFO - PROCESS | 2010 | |8;json-parse-financial;63;59;60;62;63;64;86;75;65;71 04:25:08 INFO - PROCESS | 2010 | |9;json-stringify-tinderbox;67;66;82;115;105;109;110;66;67;68 04:25:08 INFO - PROCESS | 2010 | |10;stanford-crypto-aes;86;85;86;85;87;83;88;86;90;87 04:25:08 INFO - PROCESS | 2010 | |11;stanford-crypto-ccm;140;147;127;158;153;164;147;142;175;139 04:25:08 INFO - PROCESS | 2010 | |12;stanford-crypto-pbkdf2;172;173;169;175;237;213;173;190;167;219 04:25:08 INFO - PROCESS | 2010 | |13;stanford-crypto-sha256-iterative;70;81;84;63;81;82;86;75;80;85 04:25:08 INFO - PROCESS | 2010 | __end_tp_report 04:25:08 INFO - PROCESS | 2010 | __start_cc_report 04:25:08 INFO - PROCESS | 2010 | _x_x_mozilla_cycle_collect,1058 04:25:08 INFO - PROCESS | 2010 | __end_cc_report 04:25:08 INFO - PROCESS | 2010 | __startTimestamp1462793108203__endTimestamp 04:25:08 INFO - PROCESS | 2010 | 04:25:08 INFO - PROCESS | 2010 | ------- Summary: start ------- 04:25:08 INFO - PROCESS | 2010 | Number of tests: 14 04:25:08 INFO - PROCESS | 2010 | 04:25:08 INFO - PROCESS | 2010 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.00 stddev:2.91 (2.5%) stddev-sans-first:2.87 04:25:08 INFO - PROCESS | 2010 | Values: 111.0 115.0 109.0 117.0 116.0 117.0 110.0 115.0 115.0 115.0 04:25:08 INFO - PROCESS | 2010 | 04:25:08 INFO - PROCESS | 2010 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:149.00 stddev:23.42 (15.7%) stddev-sans-first:24.71 04:25:08 INFO - PROCESS | 2010 | Values: 154.0 120.0 145.0 167.0 120.0 144.0 151.0 147.0 198.0 127.0 04:25:08 INFO - PROCESS | 2010 | 04:25:08 INFO - PROCESS | 2010 | [#2] audio-dft Cycles:10 Average:220.70 Median:220.00 stddev:30.96 (14.1%) stddev-sans-first:31.73 04:25:08 INFO - PROCESS | 2010 | Values: 198.0 196.0 197.0 215.0 252.0 276.0 259.0 192.0 197.0 225.0 04:25:08 INFO - PROCESS | 2010 | 04:25:08 INFO - PROCESS | 2010 | [#3] audio-fft Cycles:10 Average:88.70 Median:77.50 stddev:27.74 (35.8%) stddev-sans-first:28.83 04:25:08 INFO - PROCESS | 2010 | Values: 73.0 83.0 75.0 147.0 83.0 80.0 83.0 73.0 131.0 59.0 04:25:08 INFO - PROCESS | 2010 | 04:25:08 INFO - PROCESS | 2010 | [#4] audio-oscillator Cycles:10 Average:99.90 Median:78.00 stddev:29.73 (38.1%) stddev-sans-first:30.74 04:25:08 INFO - PROCESS | 2010 | Values: 81.0 98.0 133.0 71.0 75.0 95.0 121.0 67.0 99.0 159.0 04:25:08 INFO - PROCESS | 2010 | 04:25:08 INFO - PROCESS | 2010 | [#5] imaging-gaussian-blur Cycles:10 Average:92.90 Median:87.50 stddev:13.90 (15.9%) stddev-sans-first:14.63 04:25:08 INFO - PROCESS | 2010 | Values: 88.0 87.0 88.0 86.0 88.0 85.0 89.0 86.0 102.0 130.0 04:25:08 INFO - PROCESS | 2010 | 04:25:08 INFO - PROCESS | 2010 | [#6] imaging-darkroom Cycles:10 Average:99.70 Median:95.00 stddev:11.71 (12.3%) stddev-sans-first:12.24 04:25:08 INFO - PROCESS | 2010 | Values: 94.0 95.0 94.0 95.0 96.0 104.0 95.0 96.0 96.0 132.0 04:25:08 INFO - PROCESS | 2010 | 04:25:08 INFO - PROCESS | 2010 | [#7] imaging-desaturate Cycles:10 Average:111.30 Median:79.50 stddev:29.66 (37.3%) stddev-sans-first:29.64 04:25:08 INFO - PROCESS | 2010 | Values: 83.0 83.0 76.0 131.0 151.0 87.0 141.0 142.0 91.0 128.0 04:25:08 INFO - PROCESS | 2010 | 04:25:08 INFO - PROCESS | 2010 | [#8] json-parse-financial Cycles:10 Average:66.80 Median:64.50 stddev:8.32 (12.9%) stddev-sans-first:8.71 04:25:08 INFO - PROCESS | 2010 | Values: 63.0 59.0 60.0 62.0 63.0 64.0 86.0 75.0 65.0 71.0 04:25:08 INFO - PROCESS | 2010 | 04:25:08 INFO - PROCESS | 2010 | [#9] json-stringify-tinderbox Cycles:10 Average:85.50 Median:66.50 stddev:21.52 (32.4%) stddev-sans-first:21.75 04:25:08 INFO - PROCESS | 2010 | Values: 67.0 66.0 82.0 115.0 105.0 109.0 110.0 66.0 67.0 68.0 04:25:08 INFO - PROCESS | 2010 | 04:25:08 INFO - PROCESS | 2010 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:86.50 stddev:1.89 (2.2%) stddev-sans-first:2.00 04:25:08 INFO - PROCESS | 2010 | Values: 86.0 85.0 86.0 85.0 87.0 83.0 88.0 86.0 90.0 87.0 04:25:08 INFO - PROCESS | 2010 | 04:25:08 INFO - PROCESS | 2010 | [#11] stanford-crypto-ccm Cycles:10 Average:149.20 Median:150.00 stddev:13.82 (9.2%) stddev-sans-first:14.25 04:25:08 INFO - PROCESS | 2010 | Values: 140.0 147.0 127.0 158.0 153.0 164.0 147.0 142.0 175.0 139.0 04:25:08 INFO - PROCESS | 2010 | 04:25:08 INFO - PROCESS | 2010 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.80 Median:182.50 stddev:25.08 (13.7%) stddev-sans-first:25.86 04:25:08 INFO - PROCESS | 2010 | Values: 172.0 173.0 169.0 175.0 237.0 213.0 173.0 190.0 167.0 219.0 04:25:08 INFO - PROCESS | 2010 | 04:25:08 INFO - PROCESS | 2010 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.70 Median:81.50 stddev:7.30 (9.0%) stddev-sans-first:7.04 04:25:08 INFO - PROCESS | 2010 | Values: 70.0 81.0 84.0 63.0 81.0 82.0 86.0 75.0 80.0 85.0 04:25:08 INFO - PROCESS | 2010 | -------- Summary: end -------- 04:25:08 INFO - PROCESS | 2010 | 04:25:09 INFO - TEST-INFO | 2010: exit 0 04:25:09 INFO - TEST-OK | kraken | took 60415ms 04:25:09 INFO - SUITE-END | took 1172s 04:25:09 INFO - Completed test suite (00:19:32) 04:25:09 INFO - javascript benchmark 04:25:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3424.400729872273, 3457.979895930702, 3466.8959931202057, 3472.73954453416, 3501.8774342898005, 5777.884442311151, 5793.246877905872, 5869.413058694128, 5891.970540147304, 5900.498457631101, 4465.977670111653, 5681.147827825818, 5799.159121927318, 5806.506446952014, 5830.271216097988, 4120.340745480724, 4350.912981740364, 5219.086659834533, 5234.816781412651, 5346.224797404374, 146.70916173420355, 4876.587763358821, 5037.59699224063, 5205.37535495741, 5308.734563271841, 4308.913821723564, 5221.425643179266, 5283.920741188886, 5291.074062039147, 5317.335333083364, 4354.325079612665, 5288.391834938992, 5304.6286759926825, 5366.034113859504, 5369.033573956686, 4309.676774241944, 4882.048000639877, 5183.45573714762, 5228.8692782680355, 5230.320058392423, 5559.193916882029, 5695.914561281584, 5707.4577915098, 5718.628289161191, 5761.48146666802, 5113.642045056848, 6192.752289908398, 6197.845053873644, 6213.844653883644, 6252.906206406908, 6101.572889897709, 6117.644716737907, 6135.84660383494, 6161.815145545641, 6193.969030154821, 5961.314448838396, 5961.940380596182, 5973.402659734035, 5990.341062483123, 6002.639841609517, 5876.236089308362, 6118.314626315956, 6146.139540464339, 6336.524760642878, 6348.111264422984, 6120.78577249803, 6131.816045518642, 6132.569672417391, 6138.754449821957, 6146.78486252979, 6117.96941015292, 6184.81445556634, 6208.751649934043, 6232.781852635227, 6258.186435763413, 6112.321110680185, 6140.846478838065, 6176.505879529716, 6183.227096612924, 6198.907016394758, 6143.815685529441, 6151.231096112986, 6184.381561843779, 6185.103160041769, 6186.783462578788, 4923.310736496894, 4953.554180123806, 4955.306257124005, 4955.430125535538, 4972.105021096238, 3719.590845007047, 4379.824807007684, 4393.978030109829, 4469.173202957463, 4503.054358584668, 5826.359100498942, 5930.466258036798, 5959.821205363846, 5961.8211453655595, 5978.28260608721, 6209.295478023957, 6222.81331560054, 6236.158118653923, 6254.312025677172, 6262.09199666055, 5659.547236221092, 5942.524598032147, 5966.731497082642, 6003.800881565731, 6084.5436592255755, 4684.110019096361, 5349.973250133725, 5502.99999999992, 5510.834674959758, 5546.140348246028, 6018.638881667114, 6252.9370007098905, 6429.967850160813, 6441.033844923205, 6450.741970321134, 6126.30393285589, 6179.536534759821, 6213.689315534296, 6223.377662233922, 6271.027990661455, 6387.936120638734, 6394.104825324552, 6398.904016439664, 6411.198600174978, 6420.422162005442, 6194.659293738888, 6260.593061450991, 6271.74913003493, 6272.4982001440685, 6280.528960328085, 6128.625347140905, 6158.722857471335, 6166.136740856194, 6219.191505104308, 6263.248410190807, 6096.0, 6170.50635949132, 6222.564420490522, 6234.376562343729, 6253.155823963707, 5024.919642276928, 6203.875922481616, 6205.968970155301, 6231.781887633911, 6255.968720156552, 5893.528517718658, 5987.730552125252, 5999.190109335358, 6065.363136870565, 6088.665123418077, 5145.716985565829, 6034.63792172471, 6200.379962003944, 6224.533160013108, 6251.874962500816, 5884.852878678067, 6011.729472173675, 6075.605085669417, 6116.235470566179, 6129.969350153221], "value": 5641.754617105652, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [481.7831975610975, 501.2706512025002, 510.7573902396362, 532.4967905329465, 532.9706866122362, 38129.80935095324, 41109.0, 41125.58874411255, 41164.38253426194, 41186.58813411865, 40812.38781418274, 41096.79451602738, 41236.0, 41650.0, 41710.37434438486, 9545.904540954589, 9749.415035097916, 9778.0, 9795.853062204036, 9810.46042467664, 9657.179139773129, 9677.806443871119, 9703.369280996712, 9725.756856078584, 9729.464879431629, 9703.369280996749, 9714.65998690046, 9751.853722194173, 9759.951200244024, 9802.607895684165, 9683.951580242054, 9691.854622180674, 9695.22438204949, 9716.465594392306, 9751.024897510228, 9575.329726919119, 9629.422234665943, 9661.323707340489, 9666.661666841697, 9669.226461883032, 29214.561781573295, 38384.04039899025, 38403.039924001845, 38479.422808657895, 38959.0, 2767.1836808141447, 3045.2234680156416, 3084.0, 3398.9490157647656, 3461.5846098468346, 19248.90375548127, 27498.587521187197, 27620.723792762015, 28091.859540702164, 28743.712562874312, 2586.702529209146, 2649.576067829138, 2676.2907829425217, 2772.057500449857, 2838.1201827433356, 447370.0, 450620.99999999674, 450981.0, 451800.0, 453344.0, 34932.12669683278, 63900.68049659722, 64048.67975660185, 64456.67771661111, 64456.67771661111, 35508.82245588755, 36345.81827090848, 36695.81652091722, 36767.81616091902, 36809.631903681155, 15318.234088295541, 15394.23028848553, 15486.767698484531, 15536.92231538835, 15539.922300388425, 12594.559190428292, 12631.242125472501, 12775.808362874564, 12963.546275880488, 13080.28058456794, 8141.877871831927, 8178.550179740052, 8185.508869467851, 8223.177682231848, 8228.341732661373, 2981.373911478614, 2987.2830520674884, 3141.701538353853, 3255.7790828439333, 3417.128632198773, 849.8993803025097, 966.1015255812022, 975.6975337645353, 1069.4438891776388, 1083.5936523803573, 29636.0, 29925.551116733266, 30090.24774380658, 30868.53697194544, 31026.603802828926, 949.188443880486, 960.9375390599589, 1085.0776839686202, 1119.3955264157264, 1171.8535183102113, 12816.48734050646, 14567.68890799833, 15054.623634409227, 15393.538193854203, 15461.5361539154, 607527.924720756, 617689.0, 663084.0, 673708.0, 680621.0, 57096.71451642799, 57317.71341143351, 57397.71301143467, 57771.422285777444, 57973.0, 1456.9635759106106, 1462.1123281519128, 1465.5017294119837, 1470.522080323899, 1480.7556753135827, 28777.856110719313, 28834.71165288404, 29009.41981160407, 29077.374462263902, 29427.558586621646, 41785.1642967145, 49606.75196624138, 50150.74924625354, 50536.0, 50558.0, 600910.0, 602188.0, 607970.0, 610169.0, 617776.0, 26248.737512625394, 26426.867865660548, 26612.733872661025, 26616.866915665298, 26678.333041674112, 44058.33912491379, 44325.11349773051, 44492.55507445014, 44555.77722111368, 44567.77716111398, 36767.08082297857, 36826.63173368232, 37309.440358395186, 37365.252694946495, 37546.68586599456, 29792.70207297899, 36477.27045459023, 36915.63084369229, 36976.445353319185, 37373.6262637381, 32204.83897580497, 35576.46635300421, 36238.4564231542, 37081.81459092687, 37232.44151337786, 32210.033698989067, 32602.0, 33763.0, 34929.30141397107, 35205.82397087998, 23064.538709225384, 24248.0, 24730.0, 25130.37174070663, 25184.11855585046], "value": 18329.33957577023, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.3408673428639, 397.5706237263755, 398.53172522286314, 399.7441637352093, 417.57824597156883, 19643.214271429126, 21015.0, 21018.789812101873, 21063.68404473934, 21991.230306939262, 20434.69347959778, 20744.0, 21187.834669093234, 21453.249136280232, 21492.247771328006, 5707.77168913243, 5844.678542680151, 5847.006008978463, 5851.356350801409, 5897.056470964647, 5642.4357564243655, 5884.499817515516, 5898.115282707586, 5914.349421563625, 6010.849728756794, 5760.740766665489, 5796.217510636074, 5844.1818145459665, 5848.766049358021, 5849.7660093596205, 4770.189067858472, 5823.854403639901, 5835.241418615574, 5861.032929566616, 5874.97062514689, 5105.259737338102, 5111.821086262, 5116.437191908887, 5142.331496905415, 5184.818531351422, 25384.619230711553, 25691.48617027649, 25928.22215333543, 26565.0, 26716.465670686674, 2164.9025793839314, 2204.5370472200857, 2306.5271619318, 2424.097083789217, 2499.3251822008137, 8496.915030849674, 9530.0, 10024.147947424477, 14893.77659335111, 15541.456049038343, 1424.6936908564708, 1675.5392267126515, 1688.4934519644057, 1706.2251879381665, 1812.9818701812944, 105290.47354763254, 126012.36993814973, 132747.0, 133247.0, 135809.0, 11768.35274059935, 11900.107491938139, 11954.0, 11974.940125299318, 12212.511499539918, 15040.623984400478, 15189.392424302903, 15416.46042388511, 15503.922480387526, 15529.0, 7431.479796414307, 7464.880267959849, 8893.866592001124, 8955.41789783662, 9022.458652480873, 7238.963805180941, 8550.572471376407, 8829.470231786114, 8834.86747698785, 8839.46963182211, 4675.7895894684825, 4750.596199323097, 4787.8563643090765, 4811.663183577186, 4849.854504364875, 1708.4959936818668, 1952.4045166224437, 2016.637005339053, 2019.7475315585552, 2049.4261606750133, 901.8241442918568, 963.5326866469757, 998.7602975285879, 1049.9632512862013, 1084.1922767538076, 19859.205631774566, 20133.09401076955, 20614.484637884172, 20671.17315307401, 21095.578088438146, 930.0234753508789, 956.2588993529931, 978.6476868327538, 980.5342462330478, 1050.4432650695144, 7407.555546667109, 10920.0, 10973.945130274456, 10979.396133212591, 11010.724731881606, 595018.0, 602378.0, 607126.0, 611576.0, 611976.0, 70956.64521677358, 128277.0, 128900.0, 132776.68058298618, 133622.0, 1009.5860697114148, 1009.6819501856892, 1011.7521207304258, 1045.5190612318268, 1062.511244827388, 18105.0, 18193.45419637413, 18410.0, 18446.0, 18467.16897739578, 49359.50640493549, 49939.635819406336, 49955.0, 50097.0, 50668.47994560169, 70381.64809175921, 71171.64414177896, 75240.24759752551, 75759.62120189363, 82407.5879620622, 7386.519876208029, 8303.626336814737, 8310.750677479686, 8405.95797021011, 8451.66193352259, 11772.70568235801, 12856.100072995174, 12950.028747844139, 13220.537281195113, 13362.799558006443, 11178.323251512338, 11227.21409501327, 11233.775324493628, 11456.599019034295, 11592.594259200887, 10768.46157692128, 11130.610428634958, 11139.053180479426, 11283.266587672104, 11517.078633709116, 11422.600208992646, 11533.942330288295, 11639.76720465603, 11831.82252266234, 11890.643280701594, 8250.216229458192, 8261.586920653823, 8369.204925532065, 8392.244697977212, 8573.442726222776, 8509.149085091442, 10957.287776294515, 11358.659240222807, 11504.0, 11701.122415819018], "value": 9642.288721046165, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1593.960150996225, 1620.4571468558033, 1822.161805569438, 1858.9535261618457, 1923.4325873867208, 6985.650717464126, 7894.605269736505, 8455.915440845589, 8971.416857904233, 9001.774955626113, 8571.828563428728, 8616.827663446727, 8741.912580874205, 8769.123087691227, 8787.428817126882, 2453.227233421471, 2483.9379015524664, 2485.763852434025, 2487.3905893056226, 2490.56415127352, 2418.117387153685, 2478.293686299405, 2481.888315025828, 2482.379405148713, 2489.3029951613485, 2458.9016439342404, 2460.015993602555, 2460.1512478194995, 2490.713567939683, 2494.0896572750908, 1841.742156098154, 2208.8343374246915, 2438.5854404751144, 2444.327809852287, 2454.275988583372, 2395.916142934989, 2437.9146729864547, 2438.4025913651267, 2444.669969554105, 2447.5716749568933, 6546.6072035677535, 7442.702291908317, 8712.693096035582, 8780.25367843734, 8799.516026618534, 4578.2903649934315, 5318.069337865858, 5446.618736688433, 5457.836264912059, 5488.368837583649, 2628.5925681519393, 3028.0158948341877, 3517.9296414071573, 3633.727470439701, 3660.798656073915, 1027.5170669785189, 1036.8444733289991, 1038.2005855491304, 1040.921930855189, 1071.791000754853, 11338.036266917323, 11475.254108482923, 11483.712907177303, 11509.0, 11527.0, 4272.4873015237745, 4311.48262208537, 4610.847288177955, 4674.924767303539, 4975.154223781966, 9926.305158638826, 9928.900710992797, 9932.751681207883, 9948.154406875497, 9959.800803984024, 5320.627556071038, 5365.731713414314, 5425.023495770799, 5446.319210098738, 5457.181422786534, 4452.0873220989615, 4774.427068751772, 4924.630652701062, 4942.481039490874, 4980.551750342486, 4074.5517993020744, 4086.521939772399, 4114.773687447219, 4163.916721665611, 4167.812448439828, 1174.7591743692522, 1365.5766712319212, 1380.3857283508944, 1384.7092110656874, 1385.2658091211674, 916.1983264643437, 919.4161707315902, 920.3373571028849, 944.1125342178331, 968.1528662420383, 5851.063829787214, 5911.024680927599, 6016.909746353808, 6031.366706495843, 6056.939430605637, 403.8344278845659, 453.60989548987845, 460.2038473440966, 469.94595621503964, 477.22451017097217, 3927.9410808837893, 3979.7811120388656, 4054.6350828425584, 4056.9391459128137, 4061.5532291447917, 9337.859932101024, 9881.25890558211, 10584.682459526226, 10649.574017039231, 10712.410817404962, 8936.8659470108, 10310.0, 10366.378017318984, 10562.788744225227, 10746.194035447374, 6920.719666861647, 8053.83892322162, 8107.1892810718455, 8129.390295727844, 8196.877046844183, 5158.303629010185, 5841.32824725145, 5913.615614985012, 5926.140709596998, 5994.790182343597, 9892.653757118467, 9944.204463643036, 9952.303338766216, 9959.651412200537, 10050.949745251228, 9866.654667086617, 10041.698749037541, 10110.949445252727, 10112.797744045225, 10205.132563732166, 6895.0, 7314.341709246193, 7496.25037496246, 7545.056867891513, 7578.317951384402, 8369.748907532783, 8401.579921004048, 8402.87395689053, 8484.321254299517, 8493.915060849313, 7408.481406301507, 7517.661705223388, 7575.734849280248, 7631.122420921443, 7670.616469176631, 7264.89102663471, 7285.307895749896, 7296.671649775879, 7376.889346659912, 7379.262073792578, 7049.506534542533, 7066.505344625827, 7082.185548661764, 7111.893321600077, 7137.250588688113, 4353.891152721208, 4804.879878002938, 4954.950450495449, 4990.50094990498, 4994.650374473752, 4948.588669657402, 4949.678270912379, 4972.825951091694, 5048.242763585492, 5198.272241886063], "value": 4500.847243431141, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.2897052660987, 321.3588890164122, 326.9504889305329, 328.7255141956466, 331.0928057123481, 4407.316865885785, 4774.856754297368, 5416.377116631588, 5488.012157811592, 5506.449355064497, 5391.921615676871, 5401.918971215425, 5424.701641409721, 5446.210299506569, 5477.945220547794, 3711.5917249102577, 3955.782431966241, 4167.999680076775, 4182.33082706767, 4206.476114331392, 3611.5305010348616, 4047.615476529725, 4052.412400201969, 4203.087595144218, 4217.0, 4081.163361510898, 4112.465379500661, 4129.159881310396, 4133.462649855514, 4182.205380977604, 3568.0, 3979.5224573051128, 4189.22499337622, 4205.894852628679, 4214.262504061792, 3068.539719042139, 3368.747343949189, 3404.897853064412, 3670.926581468356, 3673.5775385830702, 4234.640055595278, 4890.70655760652, 5130.922506273687, 5201.55786758126, 5303.602229832778, 4024.6718582867875, 4079.5930401063515, 4608.833848091392, 4637.721736695776, 4677.532246775329, 4993.6005119590345, 5195.636305458619, 5669.348024977139, 5703.3441154267375, 5774.82675519735, 3612.060864175307, 3852.460655508231, 3900.4734360861203, 3906.1211227473877, 3924.352481840493, 4527.4114365132655, 5018.347614810088, 5843.883122337529, 5982.641041537521, 6050.45545900871, 3922.941155882664, 3950.7234493585174, 3953.7545673112877, 3982.422548730418, 4004.4794176756836, 3423.691867731916, 3874.9225015499533, 3965.237623420723, 4039.979800100981, 4060.8020633913065, 4606.0, 4650.8140424191615, 4672.813087476463, 4703.459102203222, 4704.553632111283, 4674.672772905932, 4684.531546845288, 4715.363425937523, 5320.76056577455, 5735.283089613798, 1101.5869049106584, 1183.3077649575096, 1193.498730533178, 1272.4719241514854, 1312.330711337206, 843.5866425451485, 865.4980111535294, 869.6956065377068, 880.5509190312987, 891.0, 4450.6884518083425, 4647.790849411785, 5014.423341315723, 5023.321851550067, 5053.36832895888, 4447.9293605289995, 4916.06594746997, 5297.708626025606, 5328.17413300939, 5598.193228604507, 4107.199096176217, 4127.0, 4647.465541462708, 4918.950250844499, 4990.50094990498, 2642.7357264273805, 2722.664735698793, 2727.440874620698, 2931.721486458783, 2932.6627437844495, 5261.710605916712, 5714.571307194426, 5772.826815195551, 5779.248697669276, 5836.015754643442, 4877.95122048775, 5436.0, 5561.721913904369, 5563.5271001964475, 5881.323647780475, 4850.908545577287, 5581.916271255935, 5806.44838740319, 5857.648541087548, 5863.882722345529, 5029.698218106925, 5223.92164117531, 5541.113421852484, 5555.0, 5596.664200148004, 5181.5077567631015, 5199.582194279678, 5217.165253559412, 5532.861678458071, 5605.655616896937, 5137.357830271216, 5353.892922141613, 5494.011078005998, 5582.916256256078, 5801.1878337033695, 3264.6941223510785, 3592.8383222754514, 3623.130448692242, 3626.6192049835445, 3742.6631603155847, 4914.70511769295, 4953.925691114709, 5109.718965456936, 5226.686398816083, 5750.367459579526, 5592.468715472024, 5718.313802343579, 5723.599348045597, 5745.253117094751, 5745.9425405745405, 5678.829635110953, 5711.286089238845, 5754.834840837606, 5792.82621521355, 5809.269643267658, 4988.206604301603, 5421.40364559906, 5579.525740311957, 5675.7445914933105, 5695.715214239354, 4645.3032045193495, 4790.209615413557, 4886.166023706171, 5512.200730894078, 5608.906263278622, 5050.393952725696, 5636.436356364331, 5641.210230567806, 5655.455045229745, 5717.542596592346], "value": 4035.560961724296, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.7456356484927, 618.8050764009337, 634.3879992454854, 659.633903183733, 727.8289601943542, 13212.471501139955, 15033.323500442506, 15252.618684532878, 15301.617459563517, 15336.846631533681, 13965.022448428614, 13999.0, 14070.22613756243, 14098.365573549188, 14151.999999999975, 703.4688809948507, 705.4990956420947, 830.1325115254574, 879.0286733159862, 910.7905181808155, 897.3494216692878, 901.7700486375965, 902.1339514066472, 908.604756930734, 915.0392088307251, 934.2432629570036, 936.3866667332908, 969.2633598465181, 974.1670871404953, 976.9658061967832, 924.7595625137445, 951.600327862296, 968.5883499512679, 969.8836139663285, 972.8248915195262, 703.8768215562257, 711.6761873347615, 723.616483263871, 727.3671905442299, 731.3746746531746, 14704.191269480174, 14717.190554519497, 14731.558053258419, 14818.851811481854, 14928.776068358984, 11533.8466153384, 12199.817002744965, 12905.225686458749, 13040.347982600926, 13280.867191328156, 8445.535495547743, 9925.70222893307, 10251.58993640261, 10370.429626370622, 10451.954804519562, 3523.4324153794983, 3543.2382037861985, 3566.982165089184, 3574.088607405095, 3635.4546817977252, 81294.18705812925, 81890.77163842547, 84234.73647895287, 84484.57757711172, 84759.5762021186, 9362.578683959102, 9576.90423095774, 9594.42433453981, 9605.855912161323, 9814.754631134136, 22396.664050039264, 22560.323190304316, 22983.655245171336, 22989.88505057464, 23040.308790736304, 7563.168051514329, 7592.202818704067, 7613.010308659839, 7676.232376762279, 7885.369170466349, 3682.3187710273687, 3894.4811523505855, 3988.501437320335, 4011.659008984269, 4081.3469844824685, 3513.6135025147214, 3626.9093272668392, 3627.3289441453417, 3628.9818550907075, 3634.982204982609, 627.212847875922, 630.8044506203091, 634.7365843175123, 642.6722371590522, 651.4072194303161, 507.6620279709888, 557.2031994248183, 568.573569822633, 588.6379876376084, 594.4768603628866, 7916.406269529808, 7956.562389068657, 8116.8782468263025, 8245.257926786619, 8266.545340006358, 514.2902794144057, 585.3911931591183, 585.809611876142, 587.4918195760722, 596.9432903874125, 3848.3650197717625, 3876.1472476055224, 3882.1847412043785, 3911.1395492991496, 3912.6478616924046, 90905.0, 91064.0, 92382.30470781094, 93181.53409232911, 94889.5255523718, 81004.59497702592, 81126.0, 81222.0, 82409.58795205985, 82704.58647706723, 66038.00942985955, 69560.0, 69719.65140174267, 69828.65085674539, 70273.64863175753, 7322.48742588035, 7543.962280188564, 7750.213260566899, 7760.30157285847, 7802.375809935305, 38168.473261069244, 40084.398734019596, 43447.13105737931, 43916.560834391246, 44067.55932440634, 42879.142417150855, 61185.77628447495, 62033.06950395838, 62409.375906240355, 62476.68761656163, 10238.948805255926, 10366.585336586451, 10769.892301076889, 10806.729831754268, 11019.338839669645, 11273.098152147972, 11380.94309528447, 11502.53989840397, 11617.47721352558, 11865.940670296593, 10192.439415832201, 10324.122449591869, 10415.479226038819, 10438.112760415146, 10627.840582391425, 10410.323328983592, 10500.947495262475, 10559.577616895238, 10639.202059845697, 10693.9465302673, 10234.795304093728, 10339.431331276852, 10386.480675966322, 10478.109360704426, 10600.46997650099, 8840.557972101498, 9049.079754601342, 9182.540872956459, 9415.482148481899, 9636.0, 8820.382573219813, 8960.775980600538, 9018.413803102778, 9020.684276050306, 9289.535523223947], "value": 6724.871147316217, "unit": "score"}], "name": "dromaeo_css", "value": 7040.625809548515, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 109.0, 117.0, 116.0, 117.0, 110.0, 115.0, 115.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 120.0, 145.0, 167.0, 120.0, 144.0, 151.0, 147.0, 198.0, 127.0], "value": 147.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 196.0, 197.0, 215.0, 252.0, 276.0, 259.0, 192.0, 197.0, 225.0], "value": 220.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 83.0, 75.0, 147.0, 83.0, 80.0, 83.0, 73.0, 131.0, 59.0], "value": 88.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 98.0, 133.0, 71.0, 75.0, 95.0, 121.0, 67.0, 99.0, 159.0], "value": 99.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 88.0, 86.0, 88.0, 85.0, 89.0, 86.0, 102.0, 130.0], "value": 92.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 96.0, 104.0, 95.0, 96.0, 96.0, 132.0], "value": 99.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 76.0, 131.0, 151.0, 87.0, 141.0, 142.0, 91.0, 128.0], "value": 111.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 59.0, 60.0, 62.0, 63.0, 64.0, 86.0, 75.0, 65.0, 71.0], "value": 66.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 82.0, 115.0, 105.0, 109.0, 110.0, 66.0, 67.0, 68.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 85.0, 87.0, 83.0, 88.0, 86.0, 90.0, 87.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 147.0, 127.0, 158.0, 153.0, 164.0, 147.0, 142.0, 175.0, 139.0], "value": 149.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 169.0, 175.0, 237.0, 213.0, 173.0, 190.0, 167.0, 219.0], "value": 188.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 81.0, 84.0, 63.0, 81.0, 82.0, 86.0, 75.0, 80.0, 85.0], "value": 78.7, "unit": "score"}], "name": "kraken", "value": 1629.8, "alertThreshold": 2.0}]} 04:25:09 INFO - Return code: 0 04:25:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:25:09 ERROR - # TBPL SUCCESS # 04:25:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:25:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:25:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:25:09 INFO - 2016-05-09 04:25:09.491 screenresolution[2015:13471] starting screenresolution argv=screenresolution get 04:25:09 INFO - 2016-05-09 04:25:09.493 screenresolution[2015:13471] Display 0: 1600x1200x32@60 04:25:09 INFO - 2016-05-09 04:25:09.499 screenresolution[2016:13474] starting screenresolution argv=screenresolution list 04:25:09 INFO - Available Modes on Display 0 04:25:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:25:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:25:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:25:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:25:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:25:09 INFO - Intel Iris: 04:25:09 INFO - Chipset Model: Intel Iris 04:25:09 INFO - Type: GPU 04:25:09 INFO - Bus: Built-In 04:25:09 INFO - VRAM (Dynamic, Max): 1536 MB 04:25:09 INFO - Vendor: Intel (0x8086) 04:25:09 INFO - Device ID: 0x0a2e 04:25:09 INFO - Revision ID: 0x0009 04:25:09 INFO - Displays: 04:25:09 INFO - Display: 04:25:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:25:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:25:09 INFO - Display Serial Number: 1600x1200 60 04:25:09 INFO - Main Display: Yes 04:25:09 INFO - Mirror: Off 04:25:09 INFO - Online: Yes 04:25:09 INFO - Rotation: Supported 04:25:09 INFO - Return code: 0 04:25:09 INFO - Running post-action listener: _resource_record_post_action 04:25:09 INFO - ##### 04:25:09 INFO - ##### Finished run-tests step (success) 04:25:09 INFO - ##### 04:25:09 INFO - Running post-run listener: _resource_record_post_run 04:25:10 INFO - Total resource usage - Wall time: 1207s; CPU: 55.0%; Read bytes: 491520; Write bytes: 696961024; Read time: 11; Write time: 2309 04:25:10 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 375659008; Write bytes: 370591232; Read time: 27998; Write time: 817 04:25:10 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 491520; Write bytes: 297361920; Read time: 11; Write time: 1423 04:25:10 INFO - Running post-run listener: _upload_blobber_files 04:25:10 INFO - Blob upload gear active. 04:25:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:25:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:25:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:25:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:25:11 INFO - (blobuploader) - INFO - Open directory for files ... 04:25:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:25:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:25:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:25:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:25:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:25:12 INFO - (blobuploader) - INFO - Done attempting. 04:25:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:25:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:25:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:25:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:25:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:25:13 INFO - (blobuploader) - INFO - Done attempting. 04:25:13 INFO - (blobuploader) - INFO - Iteration through files over. 04:25:13 INFO - Return code: 0 04:25:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:25:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:25:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc6705ddd136cafd872bdf5f44c6a45377e19760cf459cee0eac3e7699e5e754c968fb5a223a07297a263730573a79545e6c728bc6899fb85f20345facb175ed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1d5ab25735ea8f24c4d9faf3dbb44b5da3e5e1691cb732f5e8932ce5dcdfb8ac2f48b9043f424c42c968de1dd1ea3cf86c90cd8d9f21cdd60db25617eae3869"} 04:25:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:25:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:25:13 INFO - Contents: 04:25:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc6705ddd136cafd872bdf5f44c6a45377e19760cf459cee0eac3e7699e5e754c968fb5a223a07297a263730573a79545e6c728bc6899fb85f20345facb175ed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1d5ab25735ea8f24c4d9faf3dbb44b5da3e5e1691cb732f5e8932ce5dcdfb8ac2f48b9043f424c42c968de1dd1ea3cf86c90cd8d9f21cdd60db25617eae3869"} 04:25:13 INFO - Running post-run listener: copy_logs_to_upload_dir 04:25:13 INFO - Copying logs to upload dir... 04:25:13 INFO - mkdir: /builds/slave/test/build/upload/logs 04:25:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.766743 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-05-09 04:25:13.232846) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 04:25:13.236015) ========= 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.lkf3N2gJav/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.wH88tey5bc/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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/fc6705ddd136cafd872bdf5f44c6a45377e19760cf459cee0eac3e7699e5e754c968fb5a223a07297a263730573a79545e6c728bc6899fb85f20345facb175ed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1d5ab25735ea8f24c4d9faf3dbb44b5da3e5e1691cb732f5e8932ce5dcdfb8ac2f48b9043f424c42c968de1dd1ea3cf86c90cd8d9f21cdd60db25617eae3869"} build_url:https://queue.taskcluster.net/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011256 build_url: 'https://queue.taskcluster.net/v1/task/DIat2v2hQfSGejMISrR1og/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc6705ddd136cafd872bdf5f44c6a45377e19760cf459cee0eac3e7699e5e754c968fb5a223a07297a263730573a79545e6c728bc6899fb85f20345facb175ed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1d5ab25735ea8f24c4d9faf3dbb44b5da3e5e1691cb732f5e8932ce5dcdfb8ac2f48b9043f424c42c968de1dd1ea3cf86c90cd8d9f21cdd60db25617eae3869"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 04:25:13.266084) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:25:13.266588) ========= 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.lkf3N2gJav/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.wH88tey5bc/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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.005031 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:25:13.317686) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 04:25:13.318250) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 04:25:13.318639) ========= ========= Total master_lag: 0.17 =========