builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0139 starttime: 1472611444.76 results: success (0) buildid: 20160830173521 builduid: 1d6ba466ed6741d0a73769d39b2d1275 revision: 5931a8286060ca165423aba08b165e0c8bff71d9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 19:44:04.761312) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 19:44:04.761791) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 19:44:04.762087) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 19:44:04.785384) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 19:44:04.785723) ========= 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.eK6Hra58x7/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.A8PRgwHgsw/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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-08-30 19:44:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 152M=0s 2016-08-30 19:44:04 (152 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079019 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 19:44:04.963020) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 19:44:04.963380) ========= 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.eK6Hra58x7/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.A8PRgwHgsw/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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.020567 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 19:44:05.004393) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-30 19:44:05.004758) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5931a8286060ca165423aba08b165e0c8bff71d9 --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 5931a8286060ca165423aba08b165e0c8bff71d9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.eK6Hra58x7/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.A8PRgwHgsw/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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-08-30 19:44:05,082 truncating revision to first 12 chars 2016-08-30 19:44:05,082 Setting DEBUG logging. 2016-08-30 19:44:05,082 attempt 1/10 2016-08-30 19:44:05,082 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5931a8286060?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-30 19:44:06,204 unpacking tar archive at: mozilla-central-5931a8286060/testing/mozharness/ program finished with exit code 0 elapsedTime=1.397250 ========= master_lag: 0.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-30 19:44:06.634575) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 19:44:06.634928) ========= script_repo_revision: 5931a8286060ca165423aba08b165e0c8bff71d9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 19:44:06.635335) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 19:44:06.635619) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 19:44:06.654729) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-08-30 19:44:06.655166) ========= /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.eK6Hra58x7/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.A8PRgwHgsw/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 19:44:06 INFO - MultiFileLogger online at 20160830 19:44:06 in /builds/slave/test 19:44:06 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 19:44:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:44:06 INFO - {'append_to_log': False, 19:44:06 INFO - 'base_work_dir': '/builds/slave/test', 19:44:06 INFO - 'blob_upload_branch': 'Firefox', 19:44:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:44:06 INFO - 'branch': 'Firefox', 19:44:06 INFO - 'buildbot_json_path': 'buildprops.json', 19:44:06 INFO - 'config_files': ('talos/mac_config.py',), 19:44:06 INFO - 'default_actions': ('clobber', 19:44:06 INFO - 'read-buildbot-config', 19:44:06 INFO - 'download-and-extract', 19:44:06 INFO - 'populate-webroot', 19:44:06 INFO - 'create-virtualenv', 19:44:06 INFO - 'install', 19:44:06 INFO - 'run-tests'), 19:44:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:44:06 INFO - 'download_minidump_stackwalk': True, 19:44:06 INFO - 'download_symbols': 'ondemand', 19:44:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:44:06 INFO - 'tooltool.py': '/tools/tooltool.py', 19:44:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:44:06 INFO - '/tools/misc-python/virtualenv.py')}, 19:44:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:44:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:44:06 INFO - 'installer_path': 'installer.exe', 19:44:06 INFO - 'log_level': 'info', 19:44:06 INFO - 'log_name': 'talos', 19:44:06 INFO - 'log_to_console': True, 19:44:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:44:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:44:06 INFO - 'opt_config_files': (), 19:44:06 INFO - 'pip_index': False, 19:44:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:44:06 INFO - 'cmd': ('bash', 19:44:06 INFO - '-c', 19:44:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:44:06 INFO - 'enabled': True, 19:44:06 INFO - 'halt_on_failure': False, 19:44:06 INFO - 'name': 'check_screen_resolution'},), 19:44:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:44:06 INFO - 'cmd': ('bash', 19:44:06 INFO - '-c', 19:44:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:44:06 INFO - 'enabled': True, 19:44:06 INFO - 'halt_on_failure': False, 19:44:06 INFO - 'name': 'check_screen_resolution'},), 19:44:06 INFO - 'run_cmd_checks_enabled': True, 19:44:06 INFO - 'sps_profile': False, 19:44:06 INFO - 'sps_profile_interval': 0, 19:44:06 INFO - 'suite': 'dromaeojs-e10s', 19:44:06 INFO - 'system_bits': '32', 19:44:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:44:06 INFO - 'title': 't-yosemite-r7-0139', 19:44:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:44:06 INFO - 'use_talos_json': True, 19:44:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:44:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:44:06 INFO - 'work_dir': 'build'} 19:44:06 INFO - [mozharness: 2016-08-31 02:44:06.850320Z] Running clobber step. 19:44:06 INFO - Running pre-action listener: _resource_record_pre_action 19:44:06 INFO - Running main action method: clobber 19:44:06 INFO - rmtree: /builds/slave/test/build 19:44:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:44:08 INFO - Running post-action listener: _resource_record_post_action 19:44:08 INFO - [mozharness: 2016-08-31 02:44:08.332465Z] Finished clobber step (success) 19:44:08 INFO - [mozharness: 2016-08-31 02:44:08.332602Z] Running read-buildbot-config step. 19:44:08 INFO - Running pre-action listener: _resource_record_pre_action 19:44:08 INFO - Running main action method: read_buildbot_config 19:44:08 INFO - Using buildbot properties: 19:44:08 INFO - { 19:44:08 INFO - "project": "", 19:44:08 INFO - "product": "firefox", 19:44:08 INFO - "script_repo_revision": "production", 19:44:08 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 19:44:08 INFO - "repository": "", 19:44:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 19:44:08 INFO - "buildid": "20160830173521", 19:44:08 INFO - "pgo_build": "False", 19:44:08 INFO - "basedir": "/builds/slave/test", 19:44:08 INFO - "buildnumber": 73, 19:44:08 INFO - "slavename": "t-yosemite-r7-0139", 19:44:08 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 19:44:08 INFO - "platform": "yosemite_r7", 19:44:08 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:44:08 INFO - "branch": "mozilla-central", 19:44:08 INFO - "repo_path": "mozilla-central", 19:44:08 INFO - "revision": "5931a8286060ca165423aba08b165e0c8bff71d9", 19:44:08 INFO - "stage_platform": "macosx64", 19:44:08 INFO - "builduid": "1d6ba466ed6741d0a73769d39b2d1275", 19:44:08 INFO - "slavebuilddir": "test" 19:44:08 INFO - } 19:44:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/AbVxyZ4fR_ODYZtftAdmZA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 19:44:08 INFO - Running post-action listener: _resource_record_post_action 19:44:08 INFO - [mozharness: 2016-08-31 02:44:08.335951Z] Finished read-buildbot-config step (success) 19:44:08 INFO - [mozharness: 2016-08-31 02:44:08.336064Z] Running download-and-extract step. 19:44:08 INFO - Running pre-action listener: _resource_record_pre_action 19:44:08 INFO - Running main action method: download_and_extract 19:44:08 INFO - mkdir: /builds/slave/test/build/tests 19:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:44:08 INFO - trying https://queue.taskcluster.net/v1/task/AbVxyZ4fR_ODYZtftAdmZA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 19:44:08 INFO - Downloading https://queue.taskcluster.net/v1/task/AbVxyZ4fR_ODYZtftAdmZA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 19:44:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AbVxyZ4fR_ODYZtftAdmZA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 19:44:09 INFO - Downloaded 1199 bytes. 19:44:09 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 19:44:09 INFO - Using the following test package requirements: 19:44:09 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 19:44:09 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:44:09 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 19:44:09 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:44:09 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 19:44:09 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:44:09 INFO - u'jsshell-mac.zip'], 19:44:09 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:44:09 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 19:44:09 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 19:44:09 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:44:09 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 19:44:09 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:44:09 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 19:44:09 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:44:09 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 19:44:09 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:44:09 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 19:44:09 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:44: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:44:09 INFO - trying https://queue.taskcluster.net/v1/task/AbVxyZ4fR_ODYZtftAdmZA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 19:44:09 INFO - Downloading https://queue.taskcluster.net/v1/task/AbVxyZ4fR_ODYZtftAdmZA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 19:44:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AbVxyZ4fR_ODYZtftAdmZA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:44:10 INFO - Downloaded 16390593 bytes. 19:44:10 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 19:44:17 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:44:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:44:17 INFO - trying https://queue.taskcluster.net/v1/task/AbVxyZ4fR_ODYZtftAdmZA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 19:44:17 INFO - Downloading https://queue.taskcluster.net/v1/task/AbVxyZ4fR_ODYZtftAdmZA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 19:44:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AbVxyZ4fR_ODYZtftAdmZA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:44:18 INFO - Downloaded 16390593 bytes. 19:44:18 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 19:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:44:25 INFO - trying https://queue.taskcluster.net/v1/task/AbVxyZ4fR_ODYZtftAdmZA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 19:44:25 INFO - Downloading https://queue.taskcluster.net/v1/task/AbVxyZ4fR_ODYZtftAdmZA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 19:44:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AbVxyZ4fR_ODYZtftAdmZA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:44:26 INFO - Downloaded 14413998 bytes. 19:44:26 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 19:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:44:26 INFO - trying https://queue.taskcluster.net/v1/task/AbVxyZ4fR_ODYZtftAdmZA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:44:26 INFO - Downloading https://queue.taskcluster.net/v1/task/AbVxyZ4fR_ODYZtftAdmZA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 19:44:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AbVxyZ4fR_ODYZtftAdmZA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 19:44:29 INFO - Downloaded 111562567 bytes. 19:44:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AbVxyZ4fR_ODYZtftAdmZA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:44:29 INFO - mkdir: /builds/slave/test/properties 19:44:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:44:29 INFO - Writing to file /builds/slave/test/properties/build_url 19:44:29 INFO - Contents: 19:44:29 INFO - build_url:https://queue.taskcluster.net/v1/task/AbVxyZ4fR_ODYZtftAdmZA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:44:30 INFO - Running post-action listener: _resource_record_post_action 19:44:30 INFO - Running post-action listener: set_extra_try_arguments 19:44:30 INFO - [mozharness: 2016-08-31 02:44:30.343532Z] Finished download-and-extract step (success) 19:44:30 INFO - [mozharness: 2016-08-31 02:44:30.343659Z] Running populate-webroot step. 19:44:30 INFO - Running pre-action listener: _resource_record_pre_action 19:44:30 INFO - Running main action method: populate_webroot 19:44:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:44:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:44:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:44:30 INFO - '--tppagecycles', 19:44:30 INFO - '7'], 19:44:30 INFO - 'tests': ['tsvgm']}}, 19:44:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:44:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:44:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:44:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:44:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:44:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:44:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:30 INFO - 'talos_options': ['--disable-e10s'], 19:44:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:44:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:44:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:30 INFO - 'talos_options': ['--disable-e10s'], 19:44:30 INFO - 'tests': ['damp', 'tps']}, 19:44:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:30 INFO - 'tests': ['damp', 'tps']}, 19:44:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:44:30 INFO - 'tests': ['dromaeo_dom']}, 19:44:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:44:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:44:30 INFO - 'tests': ['basic_compositor_video']}, 19:44:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:44:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:44:30 INFO - 'tests': ['a11yr', 19:44:30 INFO - 'ts_paint', 19:44:30 INFO - 'tpaint', 19:44:30 INFO - 'sessionrestore', 19:44:30 INFO - 'sessionrestore_no_auto_restore', 19:44:30 INFO - 'tabpaint']}, 19:44:30 INFO - 'other-e10s': {'tests': ['a11yr', 19:44:30 INFO - 'ts_paint', 19:44:30 INFO - 'tpaint', 19:44:30 INFO - 'sessionrestore', 19:44:30 INFO - 'sessionrestore_no_auto_restore', 19:44:30 INFO - 'tabpaint']}, 19:44:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:44:30 INFO - 'ts_paint', 19:44:30 INFO - 'tpaint', 19:44:30 INFO - 'sessionrestore', 19:44:30 INFO - 'sessionrestore_no_auto_restore', 19:44:30 INFO - 'tabpaint']}, 19:44:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:44:30 INFO - 'ts_paint', 19:44:30 INFO - 'tpaint', 19:44:30 INFO - 'sessionrestore', 19:44:30 INFO - 'sessionrestore_no_auto_restore', 19:44:30 INFO - 'tabpaint']}, 19:44:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:44:30 INFO - 'tests': ['a11yr', 19:44:30 INFO - 'ts_paint', 19:44:30 INFO - 'tpaint', 19:44:30 INFO - 'sessionrestore', 19:44:30 INFO - 'sessionrestore_no_auto_restore', 19:44:30 INFO - 'tabpaint']}, 19:44:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:44:30 INFO - 'tests': ['a11yr', 19:44:30 INFO - 'ts_paint', 19:44:30 INFO - 'tpaint', 19:44:30 INFO - 'sessionrestore', 19:44:30 INFO - 'sessionrestore_no_auto_restore', 19:44:30 INFO - 'tabpaint']}, 19:44:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:44:30 INFO - 'tests': ['tsvgx', 19:44:30 INFO - 'tsvgr_opacity', 19:44:30 INFO - 'tart', 19:44:30 INFO - 'tscrollx', 19:44:30 INFO - 'cart']}, 19:44:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:44:30 INFO - 'tsvgr_opacity', 19:44:30 INFO - 'tart', 19:44:30 INFO - 'tscrollx', 19:44:30 INFO - 'cart']}, 19:44:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:30 INFO - 'talos_options': ['--disable-e10s'], 19:44:30 INFO - 'tests': ['tp5o']}, 19:44:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:30 INFO - 'tests': ['tp5o']}, 19:44:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:30 INFO - 'talos_options': ['--disable-e10s', 19:44:30 INFO - '--xperf_path', 19:44:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:44:30 INFO - 'tests': ['tp5n']}, 19:44:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:30 INFO - 'talos_options': ['--xperf_path', 19:44:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:44:30 INFO - 'tests': ['tp5n']}}, 19:44:30 INFO - 'talos.zip': {'path': '', 19:44:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:44:30 INFO - Running post-action listener: _resource_record_post_action 19:44:30 INFO - [mozharness: 2016-08-31 02:44:30.362303Z] Finished populate-webroot step (success) 19:44:30 INFO - [mozharness: 2016-08-31 02:44:30.362412Z] Running create-virtualenv step. 19:44:30 INFO - Running pre-action listener: _resource_record_pre_action 19:44:30 INFO - Running main action method: create_virtualenv 19:44:30 INFO - Creating virtualenv /builds/slave/test/build/venv 19:44:30 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 19:44:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:44:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:44:30 INFO - Using real prefix '/tools/python27' 19:44:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:44:31 INFO - Installing distribute.............................................................................................................................................................................................done. 19:44:34 INFO - Installing pip.................done. 19:44:34 INFO - Return code: 0 19:44:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:44:34 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:34 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:44:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:34 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 0x10f701a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f796618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbb85895c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f665d30>, '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 0x10f3cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65db20>, '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.eK6Hra58x7/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.A8PRgwHgsw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 19:44:34 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 19:44:34 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 19:44:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eK6Hra58x7/Render', 19:44:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:44:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:44:34 INFO - 'HOME': '/Users/cltbld', 19:44:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:44:34 INFO - 'LOGNAME': 'cltbld', 19:44:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:34 INFO - 'MOZ_NO_REMOTE': '1', 19:44:34 INFO - 'NO_EM_RESTART': '1', 19:44:34 INFO - 'PAGER': '/bin/cat', 19:44:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:44:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:34 INFO - 'PWD': '/builds/slave/test', 19:44:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:44:34 INFO - 'SHELL': '/bin/bash', 19:44:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A8PRgwHgsw/Listeners', 19:44:34 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 19:44:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:44:34 INFO - 'USER': 'cltbld', 19:44:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:44:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:44:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:34 INFO - 'XPC_FLAGS': '0x0', 19:44:34 INFO - 'XPC_SERVICE_NAME': '0', 19:44:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:44:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:34 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 19:44:34 INFO - Cleaning up... 19:44:34 INFO - Return code: 0 19:44:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:44:34 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:34 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:44:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:34 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f701a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f796618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbb85895c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f665d30>, '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 0x10f3cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65db20>, '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.eK6Hra58x7/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.A8PRgwHgsw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 19:44:34 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>=3.1.1'] in /builds/slave/test/build 19:44:34 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>=3.1.1 19:44:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eK6Hra58x7/Render', 19:44:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:44:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:44:34 INFO - 'HOME': '/Users/cltbld', 19:44:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:44:34 INFO - 'LOGNAME': 'cltbld', 19:44:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:34 INFO - 'MOZ_NO_REMOTE': '1', 19:44:34 INFO - 'NO_EM_RESTART': '1', 19:44:34 INFO - 'PAGER': '/bin/cat', 19:44:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:44:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:34 INFO - 'PWD': '/builds/slave/test', 19:44:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:44:34 INFO - 'SHELL': '/bin/bash', 19:44:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A8PRgwHgsw/Listeners', 19:44:34 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 19:44:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:44:34 INFO - 'USER': 'cltbld', 19:44:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:44:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:44:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:34 INFO - 'XPC_FLAGS': '0x0', 19:44:34 INFO - 'XPC_SERVICE_NAME': '0', 19:44:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:44:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:34 INFO - Downloading/unpacking psutil>=3.1.1 19:44:34 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 19:44:34 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 19:44:34 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 19:44:34 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 19:44:34 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 19:44:34 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 19:44:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:44:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:44:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:44:37 INFO - Installing collected packages: psutil 19:44:37 INFO - Running setup.py install for psutil 19:44:37 INFO - building 'psutil._psutil_osx' extension 19:44:37 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 19:44:38 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 19:44:38 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 19:44:38 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 19:44:38 INFO - building 'psutil._psutil_posix' extension 19:44:38 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 19:44:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:44:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:44:38 INFO - ^ 19:44:38 INFO - 1 warning generated. 19:44:38 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 19:44:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:44:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:44:38 INFO - Successfully installed psutil 19:44:38 INFO - Cleaning up... 19:44:38 INFO - Return code: 0 19:44:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:44: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f701a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f796618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbb85895c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f665d30>, '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 0x10f3cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65db20>, '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.eK6Hra58x7/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.A8PRgwHgsw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 19:44: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:44: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 mozsystemmonitor==0.3 19:44:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eK6Hra58x7/Render', 19:44:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:44:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:44:38 INFO - 'HOME': '/Users/cltbld', 19:44:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:44:38 INFO - 'LOGNAME': 'cltbld', 19:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:38 INFO - 'MOZ_NO_REMOTE': '1', 19:44:38 INFO - 'NO_EM_RESTART': '1', 19:44:38 INFO - 'PAGER': '/bin/cat', 19:44:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:38 INFO - 'PWD': '/builds/slave/test', 19:44:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:44:38 INFO - 'SHELL': '/bin/bash', 19:44:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A8PRgwHgsw/Listeners', 19:44:38 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 19:44:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:44:38 INFO - 'USER': 'cltbld', 19:44:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:44:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:38 INFO - 'XPC_FLAGS': '0x0', 19:44:38 INFO - 'XPC_SERVICE_NAME': '0', 19:44:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:44:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:44: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 19:44: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 19:44: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 19:44: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 19:44: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 19:44: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 19:44:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:44:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:44:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:44:41 INFO - Installing collected packages: mozsystemmonitor 19:44:41 INFO - Running setup.py install for mozsystemmonitor 19:44:41 INFO - Successfully installed mozsystemmonitor 19:44:41 INFO - Cleaning up... 19:44:41 INFO - Return code: 0 19:44:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:44:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:44:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f701a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f796618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbb85895c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f665d30>, '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 0x10f3cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65db20>, '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.eK6Hra58x7/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.A8PRgwHgsw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 19:44:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:44:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:44:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eK6Hra58x7/Render', 19:44:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:44:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:44:41 INFO - 'HOME': '/Users/cltbld', 19:44:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:44:41 INFO - 'LOGNAME': 'cltbld', 19:44:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:41 INFO - 'MOZ_NO_REMOTE': '1', 19:44:41 INFO - 'NO_EM_RESTART': '1', 19:44:41 INFO - 'PAGER': '/bin/cat', 19:44:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:44:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:41 INFO - 'PWD': '/builds/slave/test', 19:44:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:44:41 INFO - 'SHELL': '/bin/bash', 19:44:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A8PRgwHgsw/Listeners', 19:44:41 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 19:44:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:44:41 INFO - 'USER': 'cltbld', 19:44:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:44:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:44:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:41 INFO - 'XPC_FLAGS': '0x0', 19:44:41 INFO - 'XPC_SERVICE_NAME': '0', 19:44:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:44:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:41 INFO - Downloading/unpacking jsonschema==2.5.1 19:44: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 19:44: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 19:44: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 19:44: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 19:44: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 19:44: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 19:44:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:44:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:44 INFO - Downloading functools32-3.2.3-2.tar.gz 19:44:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:44:44 INFO - warning: no files found matching '*.txt' 19:44:44 INFO - no previously-included directories found matching 'build' 19:44:44 INFO - no previously-included directories found matching 'dist' 19:44:44 INFO - no previously-included directories found matching '.git*' 19:44:44 INFO - Installing collected packages: jsonschema, functools32 19:44:44 INFO - Running setup.py install for functools32 19:44:44 INFO - warning: no files found matching '*.txt' 19:44:44 INFO - no previously-included directories found matching 'build' 19:44:44 INFO - no previously-included directories found matching 'dist' 19:44:44 INFO - no previously-included directories found matching '.git*' 19:44:44 INFO - Successfully installed jsonschema functools32 19:44:44 INFO - Cleaning up... 19:44:45 INFO - Return code: 0 19:44:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:44:45 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:45 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:44:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:45 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f701a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f796618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbb85895c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f665d30>, '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 0x10f3cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65db20>, '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.eK6Hra58x7/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.A8PRgwHgsw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 19:44:45 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:44:45 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 functools32==3.2.3-2 19:44:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eK6Hra58x7/Render', 19:44:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:44:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:44:45 INFO - 'HOME': '/Users/cltbld', 19:44:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:44:45 INFO - 'LOGNAME': 'cltbld', 19:44:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:45 INFO - 'MOZ_NO_REMOTE': '1', 19:44:45 INFO - 'NO_EM_RESTART': '1', 19:44:45 INFO - 'PAGER': '/bin/cat', 19:44:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:44:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:45 INFO - 'PWD': '/builds/slave/test', 19:44:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:44:45 INFO - 'SHELL': '/bin/bash', 19:44:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A8PRgwHgsw/Listeners', 19:44:45 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 19:44:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:44:45 INFO - 'USER': 'cltbld', 19:44:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:44:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:44:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:45 INFO - 'XPC_FLAGS': '0x0', 19:44:45 INFO - 'XPC_SERVICE_NAME': '0', 19:44:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:44:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:44:45 INFO - Cleaning up... 19:44:45 INFO - Return code: 0 19:44:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:44:45 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:45 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:44:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:45 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 0x10f701a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f796618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbb85895c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f665d30>, '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 0x10f3cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65db20>, '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.eK6Hra58x7/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.A8PRgwHgsw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 19:44:45 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 19:44:45 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 19:44:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eK6Hra58x7/Render', 19:44:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:44:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:44:45 INFO - 'HOME': '/Users/cltbld', 19:44:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:44:45 INFO - 'LOGNAME': 'cltbld', 19:44:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:45 INFO - 'MOZ_NO_REMOTE': '1', 19:44:45 INFO - 'NO_EM_RESTART': '1', 19:44:45 INFO - 'PAGER': '/bin/cat', 19:44:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:44:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:45 INFO - 'PWD': '/builds/slave/test', 19:44:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:44:45 INFO - 'SHELL': '/bin/bash', 19:44:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A8PRgwHgsw/Listeners', 19:44:45 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 19:44:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:44:45 INFO - 'USER': 'cltbld', 19:44:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:44:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:44:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:45 INFO - 'XPC_FLAGS': '0x0', 19:44:45 INFO - 'XPC_SERVICE_NAME': '0', 19:44:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:44:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:45 INFO - Downloading/unpacking blobuploader==1.2.4 19:44:45 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 19:44:45 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 19:44:45 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 19:44:45 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 19:44:45 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 19:44:45 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 19:44:47 INFO - Downloading blobuploader-1.2.4.tar.gz 19:44:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:44:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:44:48 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 19:44:48 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 19:44:48 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 19:44:48 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 19:44:48 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 19:44:48 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 19:44:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:44:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:44:48 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 19:44:48 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 19:44:48 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 19:44:48 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 19:44:48 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 19:44:48 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 19:44:49 INFO - Downloading docopt-0.6.1.tar.gz 19:44:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:44:49 INFO - Installing collected packages: blobuploader, requests, docopt 19:44:49 INFO - Running setup.py install for blobuploader 19:44:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:44:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:44:49 INFO - Running setup.py install for requests 19:44:49 INFO - Running setup.py install for docopt 19:44:50 INFO - Successfully installed blobuploader requests docopt 19:44:50 INFO - Cleaning up... 19:44:50 INFO - Return code: 0 19:44:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:44:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:44:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:50 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 0x10f701a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f796618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbb85895c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f665d30>, '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 0x10f3cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65db20>, '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.eK6Hra58x7/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.A8PRgwHgsw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 19:44:50 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 19:44:50 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 19:44:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eK6Hra58x7/Render', 19:44:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:44:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:44:50 INFO - 'HOME': '/Users/cltbld', 19:44:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:44:50 INFO - 'LOGNAME': 'cltbld', 19:44:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:50 INFO - 'MOZ_NO_REMOTE': '1', 19:44:50 INFO - 'NO_EM_RESTART': '1', 19:44:50 INFO - 'PAGER': '/bin/cat', 19:44:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:44:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:50 INFO - 'PWD': '/builds/slave/test', 19:44:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:44:50 INFO - 'SHELL': '/bin/bash', 19:44:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A8PRgwHgsw/Listeners', 19:44:50 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 19:44:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:44:50 INFO - 'USER': 'cltbld', 19:44:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:44:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:44:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:50 INFO - 'XPC_FLAGS': '0x0', 19:44:50 INFO - 'XPC_SERVICE_NAME': '0', 19:44:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:44:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:44:50 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-LcV4fJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:44:50 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-JabJdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:44:50 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-r36EHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:44:50 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-DQypHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:44:50 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-Xy3_KM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:44:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:44:50 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-NWde6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:44:51 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-GdSLjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:44:51 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-9AKSbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:44:51 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-yNjVo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:44:51 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-9GRsJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:44:51 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-yoNMVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:44:51 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-VlAVlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:44:51 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-NL_Oyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:44:51 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-VJUCV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:44:51 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-K5pJmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:44:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:44:51 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-kLntyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:44:52 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-nAnYye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:44:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:44:52 INFO - Running setup.py install for manifestparser 19:44:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:44:52 INFO - Running setup.py install for mozcrash 19:44:52 INFO - Running setup.py install for mozdebug 19:44:52 INFO - Running setup.py install for mozdevice 19:44:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:44:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:44:52 INFO - Running setup.py install for mozfile 19:44:52 INFO - Running setup.py install for mozhttpd 19:44:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:44:53 INFO - Running setup.py install for mozinfo 19:44:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:44:53 INFO - Running setup.py install for mozInstall 19:44:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:44:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:44:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:44:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:44:53 INFO - Running setup.py install for mozleak 19:44:53 INFO - Running setup.py install for mozlog 19:44:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:44:53 INFO - Running setup.py install for moznetwork 19:44:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:44:53 INFO - Running setup.py install for mozprocess 19:44:53 INFO - Running setup.py install for mozprofile 19:44:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:44:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:44:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:44:54 INFO - Running setup.py install for mozrunner 19:44:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:44:54 INFO - Running setup.py install for mozscreenshot 19:44:54 INFO - Running setup.py install for moztest 19:44:54 INFO - Running setup.py install for mozversion 19:44:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:44:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:44:54 INFO - Cleaning up... 19:44:54 INFO - Return code: 0 19:44:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:44:54 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:54 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:44:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:54 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 0x10f701a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f796618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbb85895c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f665d30>, '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 0x10f3cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65db20>, '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.eK6Hra58x7/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.A8PRgwHgsw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 19:44:54 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 19:44:54 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 19:44:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eK6Hra58x7/Render', 19:44:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:44:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:44:54 INFO - 'HOME': '/Users/cltbld', 19:44:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:44:54 INFO - 'LOGNAME': 'cltbld', 19:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:54 INFO - 'MOZ_NO_REMOTE': '1', 19:44:54 INFO - 'NO_EM_RESTART': '1', 19:44:54 INFO - 'PAGER': '/bin/cat', 19:44:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:44:54 INFO - 'PWD': '/builds/slave/test', 19:44:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:44:54 INFO - 'SHELL': '/bin/bash', 19:44:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A8PRgwHgsw/Listeners', 19:44:54 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 19:44:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:44:54 INFO - 'USER': 'cltbld', 19:44:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:44:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:54 INFO - 'XPC_FLAGS': '0x0', 19:44:54 INFO - 'XPC_SERVICE_NAME': '0', 19:44:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:44:55 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-DG0CzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:44:55 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)) 19:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:44:55 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-yCTmA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:44:55 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)) 19:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:44:55 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-dFrctE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:44:55 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)) 19:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:44:55 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-QHMP4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:44:55 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)) 19:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:44:55 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-vePOA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:44:55 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)) 19:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:44:55 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-IaTJZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:44:55 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)) 19:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:44:55 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-UVEz7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:44:55 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)) 19:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:44:55 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-z8SeFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:44:55 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)) 19:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:44:55 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-m5Bk6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:44:56 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)) 19:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:44:56 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-3wiv3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 19:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:44:56 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-gRtEW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:44:56 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)) 19:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:44:56 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-0Z3DiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 19:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:44:56 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-_0yAzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:44:56 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)) 19:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:44:56 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-4y569a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 19:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:44:56 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-f6qUcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:44:56 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)) 19:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:44:56 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-JQWbaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:44:56 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)) 19:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:44:56 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-_A3MVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:44:56 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)) 19:44:56 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)) 19:44:56 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)) 19:44:56 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)) 19:44:56 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)) 19:44:56 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)) 19:44:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:44: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 19:44: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 19:44: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 19:44: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 19:44: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 19:44: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 19:44:59 INFO - Downloading blessings-1.6.tar.gz 19:44:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:44:59 INFO - Installing collected packages: blessings 19:44:59 INFO - Running setup.py install for blessings 19:44:59 INFO - Successfully installed blessings 19:44:59 INFO - Cleaning up... 19:44:59 INFO - Return code: 0 19:44:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:44:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:45:00 INFO - Reading from file tmpfile_stdout 19:45:00 INFO - Current package versions: 19:45:00 INFO - blessings == 1.6 19:45:00 INFO - blobuploader == 1.2.4 19:45:00 INFO - docopt == 0.6.1 19:45:00 INFO - functools32 == 3.2.3-2 19:45:00 INFO - jsonschema == 2.5.1 19:45:00 INFO - manifestparser == 1.1 19:45:00 INFO - mozInstall == 1.12 19:45:00 INFO - mozcrash == 0.17 19:45:00 INFO - mozdebug == 0.1 19:45:00 INFO - mozdevice == 0.48 19:45:00 INFO - mozfile == 1.2 19:45:00 INFO - mozhttpd == 0.7 19:45:00 INFO - mozinfo == 0.9 19:45:00 INFO - mozleak == 0.1 19:45:00 INFO - mozlog == 3.3 19:45:00 INFO - moznetwork == 0.27 19:45:00 INFO - mozprocess == 0.23 19:45:00 INFO - mozprofile == 0.28 19:45:00 INFO - mozrunner == 6.12 19:45:00 INFO - mozscreenshot == 0.1 19:45:00 INFO - mozsystemmonitor == 0.3 19:45:00 INFO - moztest == 0.7 19:45:00 INFO - mozversion == 1.4 19:45:00 INFO - psutil == 3.1.1 19:45:00 INFO - requests == 1.2.3 19:45:00 INFO - wsgiref == 0.1.2 19:45:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:45:00 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:00 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:00 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 0x10f701a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f796618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbb85895c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f665d30>, '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 0x10f3cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65db20>, '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.eK6Hra58x7/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.A8PRgwHgsw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 19:45:00 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 19:45:00 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 19:45:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eK6Hra58x7/Render', 19:45:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:45:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:45:00 INFO - 'HOME': '/Users/cltbld', 19:45:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:45:00 INFO - 'LOGNAME': 'cltbld', 19:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:00 INFO - 'MOZ_NO_REMOTE': '1', 19:45:00 INFO - 'NO_EM_RESTART': '1', 19:45:00 INFO - 'PAGER': '/bin/cat', 19:45:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:45:00 INFO - 'PWD': '/builds/slave/test', 19:45:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:45:00 INFO - 'SHELL': '/bin/bash', 19:45:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A8PRgwHgsw/Listeners', 19:45:00 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 19:45:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:45:00 INFO - 'USER': 'cltbld', 19:45:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:45:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:00 INFO - 'XPC_FLAGS': '0x0', 19:45:00 INFO - 'XPC_SERVICE_NAME': '0', 19:45:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:00 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)) 19:45:00 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)) 19:45:00 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)) 19:45:00 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)) 19:45:00 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)) 19:45:00 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)) 19:45:00 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)) 19:45:00 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)) 19:45:00 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)) 19:45:00 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)) 19:45:00 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)) 19:45:00 INFO - Cleaning up... 19:45:00 INFO - Return code: 0 19:45:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:45:00 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:00 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:00 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 0x10f701a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f796618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbb85895c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f665d30>, '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 0x10f3cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65db20>, '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.eK6Hra58x7/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.A8PRgwHgsw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 19:45:00 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 19:45:00 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 19:45:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eK6Hra58x7/Render', 19:45:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:45:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:45:00 INFO - 'HOME': '/Users/cltbld', 19:45:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:45:00 INFO - 'LOGNAME': 'cltbld', 19:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:00 INFO - 'MOZ_NO_REMOTE': '1', 19:45:00 INFO - 'NO_EM_RESTART': '1', 19:45:00 INFO - 'PAGER': '/bin/cat', 19:45:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:45:00 INFO - 'PWD': '/builds/slave/test', 19:45:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:45:00 INFO - 'SHELL': '/bin/bash', 19:45:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A8PRgwHgsw/Listeners', 19:45:00 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 19:45:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:45:00 INFO - 'USER': 'cltbld', 19:45:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:45:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:00 INFO - 'XPC_FLAGS': '0x0', 19:45:00 INFO - 'XPC_SERVICE_NAME': '0', 19:45:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:45:00 INFO - Cleaning up... 19:45:00 INFO - Return code: 0 19:45:00 INFO - Running post-action listener: _resource_record_post_action 19:45:00 INFO - Running post-action listener: _start_resource_monitoring 19:45:00 INFO - Starting resource monitoring. 19:45:00 INFO - [mozharness: 2016-08-31 02:45:00.572967Z] Finished create-virtualenv step (success) 19:45:00 INFO - [mozharness: 2016-08-31 02:45:00.574000Z] Running install step. 19:45:00 INFO - Running pre-action listener: _resource_record_pre_action 19:45:00 INFO - Running main action method: install 19:45:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:45:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:45:00 INFO - Reading from file tmpfile_stdout 19:45:00 INFO - Detecting whether we're running mozinstall >=1.0... 19:45:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:45:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:45:00 INFO - Reading from file tmpfile_stdout 19:45:00 INFO - Output received: 19:45:00 INFO - Usage: mozinstall [options] installer 19:45:00 INFO - Options: 19:45:00 INFO - -h, --help show this help message and exit 19:45:00 INFO - -d DEST, --destination=DEST 19:45:00 INFO - Directory to install application into. [default: 19:45:00 INFO - "/builds/slave/test"] 19:45:00 INFO - --app=APP Application being installed. [default: firefox] 19:45:00 INFO - mkdir: /builds/slave/test/build/application 19:45:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:45:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:45:35 INFO - Reading from file tmpfile_stdout 19:45:35 INFO - Output received: 19:45:35 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:45:35 INFO - Running post-action listener: _resource_record_post_action 19:45:35 INFO - [mozharness: 2016-08-31 02:45:35.393115Z] Finished install step (success) 19:45:35 INFO - [mozharness: 2016-08-31 02:45:35.393287Z] Running run-tests step. 19:45:35 INFO - Running pre-action listener: _resource_record_pre_action 19:45:35 INFO - Running main action method: run_tests 19:45:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:45:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:45:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:45:35 INFO - 2016-08-30 19:45:35.408 screenresolution[1913:13136] starting screenresolution argv=screenresolution get 19:45:35 INFO - 2016-08-30 19:45:35.410 screenresolution[1913:13136] Display 0: 1600x1200x32@60 19:45:35 INFO - 2016-08-30 19:45:35.416 screenresolution[1914:13138] starting screenresolution argv=screenresolution list 19:45:35 INFO - Available Modes on Display 0 19:45:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:45:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:45:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:45:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:45:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:45:35 INFO - Intel Iris: 19:45:35 INFO - Chipset Model: Intel Iris 19:45:35 INFO - Type: GPU 19:45:35 INFO - Bus: Built-In 19:45:35 INFO - VRAM (Dynamic, Max): 1536 MB 19:45:35 INFO - Vendor: Intel (0x8086) 19:45:35 INFO - Device ID: 0x0a2e 19:45:35 INFO - Revision ID: 0x0009 19:45:35 INFO - Displays: 19:45:35 INFO - Display: 19:45:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:45:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:45:35 INFO - Display Serial Number: 1600x1200 60 19:45:35 INFO - Main Display: Yes 19:45:35 INFO - Mirror: Off 19:45:35 INFO - Online: Yes 19:45:35 INFO - Rotation: Supported 19:45:35 INFO - Return code: 0 19:45:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:45:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:45:35 INFO - Python 2.7.3 19:45:35 INFO - Return code: 0 19:45:35 INFO - grabbing minidump binary from tooltool 19:45: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:45: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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f665d30>, '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 0x10f3cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f65db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:45: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 19:45: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 19:45:35 INFO - Calling ['/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'] with output_timeout 600 19:45:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:45:35 INFO - Return code: 0 19:45:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:45:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:45:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:45:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:45:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:45:35 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/AbVxyZ4fR_ODYZtftAdmZA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0139', '--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 19:45:35 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/AbVxyZ4fR_ODYZtftAdmZA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0139 --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 19:45:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eK6Hra58x7/Render', 19:45:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:45:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:45:35 INFO - 'HOME': '/Users/cltbld', 19:45:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:45:35 INFO - 'LOGNAME': 'cltbld', 19:45:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:45:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:45:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:35 INFO - 'MOZ_NO_REMOTE': '1', 19:45:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:45:35 INFO - 'NO_EM_RESTART': '1', 19:45:35 INFO - 'PAGER': '/bin/cat', 19:45:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:45:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:45:35 INFO - 'PWD': '/builds/slave/test', 19:45:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:45:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:45:35 INFO - 'SHELL': '/bin/bash', 19:45:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.A8PRgwHgsw/Listeners', 19:45:35 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 19:45:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:45:35 INFO - 'USER': 'cltbld', 19:45:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:45:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:45:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:35 INFO - 'XPC_FLAGS': '0x0', 19:45:35 INFO - 'XPC_SERVICE_NAME': '0', 19:45:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:45:35 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/AbVxyZ4fR_ODYZtftAdmZA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0139', '--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 19:45:36 INFO - mozversion application_buildid: 20160830173521 19:45:36 INFO - mozversion application_changeset: 5931a8286060ca165423aba08b165e0c8bff71d9 19:45:36 INFO - mozversion application_display_name: Nightly 19:45:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:45:36 INFO - mozversion application_name: Firefox 19:45:36 INFO - mozversion application_remotingname: firefox 19:45:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:45:36 INFO - mozversion application_vendor: Mozilla 19:45:36 INFO - mozversion application_version: 51.0a1 19:45:36 INFO - mozversion platform_buildid: 20160830173521 19:45:36 INFO - mozversion platform_changeset: 5931a8286060ca165423aba08b165e0c8bff71d9 19:45:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:45:36 INFO - mozversion platform_version: 51.0a1 19:45:36 INFO - using testdate: 1472611536 19:45:36 INFO - actual date: 1472611536 19:45:36 INFO - starting webserver on 'localhost:51502' 19:45:36 INFO - SUITE-START | Running 2 tests 19:45:36 INFO - TEST-START | dromaeo_css 19:45:36 INFO - operating with platform_type : mac_ 19:45:36 INFO - Initialising browser for dromaeo_css test... 19:45:36 INFO - TEST-INFO | started process 1924 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmpAL5p55/profile http://localhost:51502/getInfo.html) 19:45:38 INFO - PROCESS | 1924 | __metrics Screen width/height:1600/1200 19:45:38 INFO - PROCESS | 1924 | colorDepth:24 19:45:38 INFO - PROCESS | 1924 | Browser inner width/height: 1024/689 19:45:38 INFO - PROCESS | 1924 | __metrics 19:45:38 ERROR - PROCESS | 1924 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 19:45:39 INFO - TEST-INFO | 1924: exit 0 19:45:39 INFO - Browser initialized. 19:45:39 INFO - Running cycle 1/1 for dromaeo_css test... 19:45:39 INFO - TEST-INFO | started process 1927 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmpAL5p55/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:45:51 INFO - PROCESS | 1927 | RSS: Main: 243949568 19:45:51 INFO - PROCESS | 1927 | 19:46:41 INFO - PROCESS | 1927 | 1472611601123 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] 19:48:53 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:51502/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51502/tests/dromaeo/cssquery-ext.html) 19:48:54 INFO - PROCESS | 1927 | RSS: Main: 266280960 19:48:54 INFO - PROCESS | 1927 | 19:51:57 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:51502/tests/dromaeo/cssquery-ext.html (next: http://localhost:51502/tests/dromaeo/cssquery-jquery.html) 19:51:57 INFO - PROCESS | 1927 | RSS: Main: 274571264 19:51:57 INFO - PROCESS | 1927 | 19:54:59 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:51502/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51502/tests/dromaeo/cssquery-mootools.html) 19:55:00 INFO - PROCESS | 1927 | RSS: Main: 273174528 19:55:00 INFO - PROCESS | 1927 | 19:58:02 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:51502/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51502/tests/dromaeo/cssquery-prototype.html) 19:58:03 INFO - PROCESS | 1927 | RSS: Main: 268218368 19:58:03 INFO - PROCESS | 1927 | 20:01:06 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:51502/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51502/tests/dromaeo/cssquery-yui.html) 20:01:06 INFO - PROCESS | 1927 | RSS: Main: 273682432 20:01:06 INFO - PROCESS | 1927 | 20:04:09 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:51502/tests/dromaeo/cssquery-yui.html (next: http://localhost:51502/tests/dromaeo/cssquery-dojo.html) 20:04:09 INFO - PROCESS | 1927 | RSS: Main: 277540864 20:04:09 INFO - PROCESS | 1927 | 20:04:09 INFO - PROCESS | 1927 | __start_tp_report 20:04:09 INFO - PROCESS | 1927 | _x_x_mozilla_page_load 20:04:09 INFO - PROCESS | 1927 | _x_x_mozilla_page_load_details 20:04:09 INFO - PROCESS | 1927 | |i|pagename|runs| 20:04:09 INFO - PROCESS | 1927 | |0;dojo.html;3410.931781364373;3448.413769659158;3473.287975964926;3482.3383557124143;3487.250241198142;5661.8584535386635;5755.25181726375;5761.913571296429;5761.942380576198;5843.970780146104;4710.505396933324;5716.657000579969;5725.513331366828;5725.828225153242;5755.482006619403;5140.074786538422;5148.588112950955;5213.504717051893;5223.921641175385;5296.364436267634;4816.855494335158;5116.925445656417;5197.324347834776;5330.173823057432;5360.517553420192;5164.328637277167;5172.637915345908;5239.266502689627;5276.709780962045;5338.199270109476;5257.605679574047;5268.92096618551;5276.393214780311;5283.788648454057;5286.07493688603;5197.376314842205;5253.789848406059;5272.710000949946;5293.57651387888;5298.92051619226;4638.327442520816;5493.121100623881;5727.885442291131;5747.453991870766;5761.539076873882;6112.449879510821;6197.783077592308;6217.658028808413;6231;6237.126802247689;6245.422066759335;6285;6295.150154729099;6297.811065668037;6327.398897104814;5680.971595142039;5764.798232061858;5766.933117373257;5784.739686714108;5805.187273781674;6236.563440559208;6247.468965138014;6289.245290565162;6292.433680968643;6348.04779283102;6166.599171053867;6222.657753823492;6226;6229.875402491924;6231.844203894939;6073.180120683651;6251.281102673251;6264.718087686065;6287.056941458726;6308.621482711052;6137.622145770991;6191;6221.968890155611;6258.812235632939;6266.216722909637;6234.501239900797;6265.122882796412;6287.874242515124;6294.811155665246;6308.8422789429715;4300.440942677432;4844.32179494871;4886.95113048865;4917.7786999585105;4987.226979818134;4418.756968366706;4426.402435671208;4478.149151661174;4485.865424037284;4487.237169681162;5814.156947242626;5891.1457838614015;5921.289445266596;5922.2597175353085;5955.910661340084;6101.429060711456;6305;6307.495400368051;6310.9368906311265;6323.146375239376;4830.855074347775;5845.649261044351;5892.793752218652;5950.583459157818;5986.07215881539;4484.865454036384;5467.917981230285;5473.124300111963;5476.91784623231;5485.204645326406;6226.782062627786;6404.871902561923;6465.741370345134;6473.8705225896165;6477.060826180272;4966.956939042841;5123.692578445305;5265.973670131625;6087.391260874055;6137.714085983886;5248.396434409939;6301.842453938505;6316.431521163117;6350.206224221973;6367.93632063692;5329.760160792696;6093.664848433202;6178.69106544662;6199.814005579839;6204.317525072329;5586.190002449704;5594.797118619516;5625.987322282029;5696.943030569641;6217.409346112112;6138.9095594588325;6146.047362658616;6192.040233763774;6212.161358216583;6231.813045608639;5972.25346831646;6148.077788331786;6154.569180157346;6162.506999440124;6170.568060235741;5865.677387743544;6009.939900600938;6048.848778780566;6083.026715725463;6126.6017708848785;5032.723200224023;6139.6009259398;6149.877002460015;6155.569110162425;6178.474829639351;5583.916241256303;5979.850503737442;5991.7902873399225;5991.940080599138;5995.1906492624685 20:04:09 INFO - PROCESS | 1927 | |1;ext.html;450.58546137553446;473.27825066773187;496.95278948499885;539.514437006694;573.5239751006665;37363.43954840679;39310;39328.60671393285;39333.80333098334;39338.21323573527;40356.59643403565;40549.98625034368;40684;40734.29719839225;40799.796001020026;9421.71734847954;9639.71080867575;9656.130948214659;9658.903410965906;9683.41899486033;8116.431849770489;9590.856137157949;9625.470599117045;9628.35220314412;9636.469994150319;9640.903590964072;9655.372400793962;9668.226541876667;9670.323077384586;9702.22382209425;8168.836623267561;9605.886704924906;9653.855192172088;9660.806783864284;9664;9552.713418597454;9604;9606.423614583147;9645;9653.662121825773;38641.80679096615;38911.02722431933;38967.22065558673;38990;39080;3219.9517007244676;3260.3805276997296;3311.503274508819;3508.9649103508896;3756.9248615027545;30065.549016764766;30081.69918300811;30623.846880765675;30891.91878284249;31126.84436577825;3168.5088811234295;3220.951685724716;3226.6450690424035;3227.3706627207703;3375;455009;458295;458832;462599.6870015662;462973;55103.724481377336;55412.16881746777;55413.168802468;55480;55498;33102.5311582938;33583.664163358546;33926.66073339235;34849.82575087108;34891.82554087213;16029.759553606706;16123.83876161247;16217.026978381335;16234.107124108288;16254.268557914922;12361.258324500379;12445.937770311091;12456.128071035122;12464.376781160905;12495.312757798227;17820.19809108593;18372;18387.89672619647;18464.446066618024;18497.630047398976;6497.122888410004;6670.898666920002;7784.338331241795;7923.009623797026;7947.3642108631175;814.9266566009088;933.4772527384687;944.5513381143902;964.7154089543601;974.6296407365156;23905.04379824822;24237.394065148514;25239.74760252411;29046.692898819605;30122.945696900504;891.3092353426017;945.9054094590623;975.9072888075622;991.1872264742842;1092.4865313302735;14699.41202351894;15156.924215378853;15160.241987900561;15346.846531534542;15565.455209067628;653650;655526;661256.5497380147;662094;665364;55327.17009244864;56294.71852640711;56324.15513767297;56482.7175864118;56680.14979775307;1311.6917524381763;1327.9601611951657;1349.4602159136227;1380.0339762166523;1385.7505648983079;27428.67927527015;28365.432691346472;28450;28916.542093922253;29007.274818129714;46842.06315873595;47115;47357;47458.28812567883;47514.76242618765;579490;580461;580699;580864;581498;25008.623835781935;25637.871810640827;25947.22158335253;25960.610590840774;26011.089611863496;44871.77564112289;45650.54349456463;46306.30540541827;46736.065278694914;46897.29654055124;38097.61902381052;38197.61802381941;38221.61778382292;39451;39516.40725389179;37528.81235593805;37796.62203377931;37949.051273718374;38751.806240969745;39155;36674.44988325231;37545.62454375421;37577.81211093927;37726.62273377231;38078;25755.742442575334;31092.844535777178;33518;33791.49312760261;34046.148846279044;22506.662400063684;25117.74882251154;25128.497430051662;25421.61867572025;25765.3558661035 20:04:09 INFO - PROCESS | 1927 | |2;jquery.html;357.787116665584;359.8326778048207;368.4565266232308;376.6741768370357;387.9641357575274;11724.179307448472;12149.878501214986;12284.815727764068;12293;19876.00619969003;21807.781922180773;21941.232056878012;22876.771232287672;23045.423864403398;23080.65379019316;6602.9669851650915;6634.933650663504;6946.027556142144;6959.478039147059;6968.825779355531;5824.475797178253;6724.428423584001;6847.965760171192;6888;6907.758228462005;6538.509611779112;6763.222229443628;6822.6929788159405;6879.27767584404;6880;5993.610415323012;6512.967435162841;6770.0860383848285;6821.965890170567;6822.692978815965;6533.314002029766;6571.342865713438;6589.385600527853;6593.241777195636;6596.43930265928;28294.71705282962;28977;29391.677374518196;29525.40949181004;29647.70352296471;1913.473794706453;2035.5013021809752;2157.6332023555874;2464.5440593490084;3059.816411015346;16210.94138967993;16798.58003549909;17034.955805303318;17048.2328295227;17743;1979.2478858033999;2024.595080983809;2041.3467690339098;2081.2819577245828;2082.9479263018393;104658;106336.40495392575;125964;145235;152077;16307.429239976544;16530.173491325386;19844;21051.368458946257;21083.578328433345;34731;35401.93794186178;35479;35560.64439355573;35656;10508.159347252202;10809.459527023775;11016.06363459115;11077.889221107847;11161.274517156358;7297.343239108506;8984.416012959136;8997;9148;9218.58516366765;9681.273904457194;9757.463339516253;9898.653547125816;9954.950225248827;9968.302218844612;3191.856366463515;3801.790901500444;3814.6376094271;3831.1188426662025;3920.3335432976464;787.338635546144;888.6625628429173;910.9544522773834;926.7173512078881;939.6241503398695;16951.728620353522;17066.2320195589;17491.91254043747;17677.823221767874;19453.416397507815;869.1786261982365;876.4784952952983;890.8797312362748;905.2712566384124;928.7028150991753;10622.628208012682;11034.889651103547;11053.613123540637;11067.557297708163;11078.944605276922;593123;598900;602329;603524.5520015026;608260;109079;119081;132135.33932330276;136502.31748841392;136888.31555842157;909.30892521684;936.9250459963187;957.5834511987308;958.324381311174;969.0890562870878;15994;18611.90694046521;18788.81211187925;18955.336563220222;19197.808021920162;52440;57303.71348143233;57489.137662934256;57655.423445765;58485;84048;84229.57885210535;85074;85415.14584854072;86104.27791444011;6430.710618022294;6751.662416879235;7822.608869556613;8039.356851451753;8140.59297035134;10259.17926565858;12460.813087803508;12551.87448125507;12567.66956756442;12620.936895315464;8601.612927418406;10602.416867072385;10716.839247411139;10895.564177432814;11036.227464077438;9621.56702948383;10404.531796069346;10810.621628242974;10838.837417438586;11042.282251653616;9666.888307844687;10074.798504030025;10895.727606809893;11111.777764444827;11293;7366.189719130998;7383.07711536058;7905.723299684483;8038.718644847402;8174.959125204336;10245.334053286513;10868.456577171268;11134.944325278322;11179.888201117885;11258.21192516516 20:04:09 INFO - PROCESS | 1927 | |3;mootools.html;1464.9853501464984;1518.3601710153036;1749.247823435922;1882.548188434776;1910.245453046046;8123;8586;8810.735677929672;9184.632614695412;9188.632454701812;8788.252998495136;9013.41412808167;9022.097790220974;9044.3668943174;9057.456552606849;2418.7097548294228;2431.987840060797;2432.659427680126;2439.2194497760725;2446.00936620668;2005.2680771518365;2387.617981123021;2408.614621660535;2421.7336093029753;2432.781049705526;2360.8465449745713;2370.5851475991717;2378.5718570657273;2383.6424536319605;2389.940251493709;2351.4356554426986;2362.078789272185;2388.5461762265113;2398.0527691561824;2413.54142712884;2374.833761636686;2387.594109001474;2396.760323967607;2402.9519409611885;2406.4946361264156;9031.638734450615;9104.499252541107;9106.40808347462;9116.498592577405;9126.863097053549;5322;5533.750981205855;5535.557155427597;5540.085885828834;5549.5837812163845;3572.1962558424407;3702.5556933167923;3718.7768733876055;3770.170562476251;3782.470454136396;1082.5290998415635;1087.190043417651;1092.847001419794;1109.5617231193633;1111.744298811278;11889.821652675217;11890.048796096291;11922.046236301076;11962.760744785142;12019.579314723942;4429.712068715523;4545.272756358967;4693.882652933704;4701.506341834127;4737.976310118427;9186;9283.39657922233;9317.11487408695;9381.718548443558;9406.43561386319;5295.470452954673;5340.546053585489;5344.545713614386;5361.222622719683;5364.678119312854;4468.262736648417;4854.781534830941;4979.975100124476;4992.500749924979;5019.247112933089;3757.0043938356357;3822.9235415291537;3863.6715879150024;3897.980510097488;3924.4898163238595;1178.3048001679051;1189.5717541684987;1193.958211462612;1194.510250797169;1196.1806162778526;908.9636414543477;924.4869097650734;937.554661535765;944.8110377924443;945.2823133491213;5687.971560142173;5764.221830052973;5926.614770039933;5983.252093488314;6296.905546416808;416.26113648274554;423.69282270353744;441.6731618602211;445.4476449202965;451.109059607273;3945.3292940200236;4008.6191811777835;4090.3046482098116;4125.154343359604;4150.8547200848425;10813.56745730162;11027.283226590245;11100.44497775108;11167.609133680282;11172.553097876156;10715.46422678863;11091.112710983101;11122.610708625321;11141.721456963478;11158.218924675357;8183.63173657175;8403.579821008925;8463.830723385498;8464.195901389481;8469.618867150994;5094.898102038012;5863.765449381977;5956.731947062479;5998.580099393001;6044.57687961856;8353.498790072616;10289.9485502572;10338.483075846027;10341.63804266847;10392.948035259775;10222.591096356062;10303.793924121626;10335.844962325722;10527.684169474927;10581.576736930436;6494.447971922251;6608.273089960197;7086.433085353056;7193.280671932765;7245.855082898418;8563.743087707378;8566.91433085661;8642.956785216034;8655.264302534104;8677.088905664814;7584.620768961419;7702.576358300347;7706.113796913202;7798.688052477837;7837.7648670539975;7401.740939067106;7511.399088073051;7556.1310449299035;7581.431392645684;7669.923300766921;7011.544249623758;7096.183938847099;7155.892661609976;7163;7188.964055179691;4574.748388838646;4873.293372461044;5049.747512624281;5086.262491938722;5162.457941916045;5086.516780905956;5151.304573882478;5246.921296180637;5259.237410575522;5273.973630131824 20:04:09 INFO - PROCESS | 1927 | |4;prototype.html;300.3632299525007;302.53258715284886;309.61143764575456;314.27402699763536;314.54077047510634;5302.787888484456;5377.8117765878205;5443.836684899455;5502.779888804448;5535.308086489194;4929.383827021622;5372.382176049746;5456;5469.249840051185;5496.560275177986;3345.7825241359296;3556.76881002734;3629.909252268701;3672.889813305592;4173.582641735818;3152.148919791655;3632.1101330174142;3970.260520241039;4210.305299625558;4215.557366476522;3363.663633636629;4123.5876412358675;4142.730722503043;4154.646855017327;4159.854405095823;3812.9514383544747;3936.933110117183;4154.293770059097;4157.584241575833;4174.660271782592;3603.351396748584;3617.276544691072;3626.9274614507826;3636.7454278200535;3642;4435.733855968652;4558.316252562142;4957.330760347343;5258.526732594047;5322.414534401213;3978.9801050994847;4453.198424283628;4769.952300476985;4787.234042553209;4790.305405716152;5080.060188865072;5270.235815806686;5510.421405752419;5530.617345663584;5907.497862681677;3009.3529891073526;3401;3450.706689931359;3557.804320762357;3858.2862170498547;5038.974805125951;5594.328680558318;5805.477507024388;6082.178905847698;6136.527233463981;3260.347930413927;3679.392900171442;3730.4590834329415;3829.923401531954;4010.578889216649;3851.171998020383;4072.9796351018053;4100.36444351126;4108.342665173617;4119.8970025748995;3966.7024973126554;4680.134175177603;4688.343631891538;4802.84731664398;4810.494898035726;5293.285406470077;5782.797602083907;5843.766249349978;5868.471837534642;5871.853203669943;1321.2799024531653;1374.0244426457127;1374.8281464816898;1389.4789453954768;1396.1483495068;885.9988213318908;910.3081657940013;919.9586018629178;931.6133804471204;955.8996305387973;4676.18166820805;4817.349657796222;4921.138800709861;5298.7350632469;5347.5294294069445;5770.2498675171955;5795.710214489259;5856.862245280442;5895.587308888336;5901.911471327933;4411.005677532078;4674.247157316006;5312.335958005249;5337.306150200449;5395.489263006364;2290.7365652949793;2310.0297874892585;2383.8212134090013;2541.8474891506567;2589.9352516187246;4207.726497777635;4445.911081778347;5187.948120518822;5203.479652034766;5244;4270.839578711793;4626.0608939669155;4670.673052886265;5002.59979201663;5089.745512724349;4166.41670166183;4615.976920115378;4989.850304490871;5154.9174673318275;5165.48345165488;4700.694454860423;4907.582855457326;4911.533404326583;4944.629152813482;4973.518537024025;4574.124608910331;4761.166950723927;4855.514448555116;4866.732329721899;4901;4617.976910115428;5106.693598384109;5143.92284115731;5145.713571607098;5194.454582268807;3045.3151686458746;3401.2857299967286;3406.642302558295;3492.9825350873084;3504.4392897136336;4074.8777536673947;4782.760861956818;4862.781174847211;4907.822122690457;5099.87250318745;5345.679259244303;5684.9431505684415;5781.121135630852;5811.651300921958;5832.183494310885;5028.59771218309;5797.130430435468;5839.5912286141265;5850.899023517542;5858.882822343615;4306.633936115465;4756.405449318835;5073.492650734897;5503.174523821459;5724.542036637143;4854.611631069577;5885.293764748087;5919.467247947706;5940.960331941979;5971.313298970674;4987.977464619817;5100.285959965534;5271.920921186109;5788.829189054105;5793.971030144822 20:04:09 INFO - PROCESS | 1927 | |5;yui.html;687.573704303332;701.9824504387393;703.70092710598;752.4281546025023;825.4304529874388;15374.308156132973;15953.84046159538;16129.919350403261;16211.432599859007;16250.756238656415;14572.344244508997;15158.393664253417;15759.60600984976;15898.602534936603;16208.027518348907;818.6929901287017;843.8818565400849;847.1824689174945;849.0702680564772;849.5115308697524;672.5897202706345;818.9754307370788;838.6477679374647;844.0968164064423;846.724814435308;900.6487469886749;901.923336516397;901.9323550733722;902.0888902208784;903.7153296711548;879.2218886285651;896.0680891872478;897.869808877709;898.5417437107089;899.2356496977582;644.7485480662546;645.3610925184034;663.1842833315002;667.9064930909676;670.0184230102923;15464;15468.303926323342;15468.76796848037;15479.922600386926;15480;10670.466476676213;10879.728006799893;12242.571509997197;12348.38258087101;14159.22124283164;9749.853752193723;11611;11755.35345555994;11841.467133978991;11953.043756499459;3733.9439908401396;3748.269087527933;3764.360058789985;3782.413725872494;3791.7724936503896;86791;113777;116639.66720665625;119076.40461797723;119577;10653.573857045787;10756.193285503463;10758.354498730101;10821.513031913426;11197.608083717194;22282.331530054125;22322.330330090124;22364.55270894573;22364.55270894573;22441;7660.693572257159;7816.10114836801;7826.647800848861;7911.406644501571;8016.038075430985;4305.225059489322;4432.689711720213;4436.646822719037;4437.267850804581;4446.933296000562;3474.652534746505;3564.625714300013;3590.8922732318074;3592.263585964871;3749.250149970017;593.2288025566746;656.2617055812211;705.2735682247294;714.2857142857143;729.2015243308568;554.384633057306;580.5442727459009;634.2104080419815;667.8063361625075;675.2470994840816;9040.276777857756;9072.682456114004;9367.297452691075;9478.857817132748;9669.613215471443;562.9324481062217;638.1958731997717;649.4890851128174;662.3145044878623;669.4811521071111;4366.934495982563;4436.157130145262;4536.79584418702;4549.863504094882;4646.831818747666;84409.7795110242;155783.44216557688;157592.63611045844;158429.20785396;158953;111115;135384.6461535392;136777;136802;138585;98161.509192455;118209.40895295469;121913;122552;123231;8820.25027872638;8843.336749743667;8851.557422128997;8907.955460222658;8954;52879;61238.4690382744;63767.724645507755;67089.66455167693;67814.66092669505;79608;81821;86100.56949715212;86569;86935.56532217299;13221.471141154247;13281.335933203494;13297.468101275841;13582.728345433234;13602.319884005958;14417.207053612152;14447.49433769813;14672.413103475741;14838.925805370904;14960.551183464513;13697.383617737027;13825.79261311061;13863;14100.435982560582;14444.988850780344;13496.122752021087;13849.238291894042;14070.507532236323;14121.717565648834;14375;13565.050446468653;13845.861541384456;13964.022518423613;14180.432782688576;14282.928780341725;10983.780324393627;11049.944750276518;11248.344288106562;11511.19421640477;11667.883321167019;9050.456972581665;9713.514324283899;10976.562694419132;11358.148138889452;11664.416779161178 20:04:09 INFO - PROCESS | 1927 | __end_tp_report 20:04:09 INFO - PROCESS | 1927 | __start_cc_report 20:04:09 INFO - PROCESS | 1927 | _x_x_mozilla_cycle_collect,391 20:04:09 INFO - PROCESS | 1927 | __end_cc_report 20:04:09 INFO - PROCESS | 1927 | __startTimestamp1472612649727__endTimestamp 20:04:09 INFO - PROCESS | 1927 | 20:04:09 INFO - PROCESS | 1927 | ------- Summary: start ------- 20:04:09 INFO - PROCESS | 1927 | Number of tests: 6 20:04:09 INFO - PROCESS | 1927 | 20:04:09 INFO - PROCESS | 1927 | [#0] dojo.html Cycles:165 Average:5702.97 Median:5921.29 stddev:661.34 (11.2%) stddev-sans-first:638.46 20:04:09 INFO - PROCESS | 1927 | Values: 3410.9 3448.4 3473.3 3482.3 3487.3 5661.9 5755.3 5761.9 5761.9 5844.0 4710.5 5716.7 5725.5 5725.8 5755.5 5140.1 5148.6 5213.5 5223.9 5296.4 4816.9 5116.9 5197.3 5330.2 5360.5 5164.3 5172.6 5239.3 5276.7 5338.2 5257.6 5268.9 5276.4 5283.8 5286.1 5197.4 5253.8 5272.7 5293.6 5298.9 4638.3 5493.1 5727.9 5747.5 5761.5 6112.4 6197.8 6217.7 6231.0 6237.1 6245.4 6285.0 6295.2 6297.8 6327.4 5681.0 5764.8 5766.9 5784.7 5805.2 6236.6 6247.5 6289.2 6292.4 6348.0 6166.6 6222.7 6226.0 6229.9 6231.8 6073.2 6251.3 6264.7 6287.1 6308.6 6137.6 6191.0 6222.0 6258.8 6266.2 6234.5 6265.1 6287.9 6294.8 6308.8 4300.4 4844.3 4887.0 4917.8 4987.2 4418.8 4426.4 4478.1 4485.9 4487.2 5814.2 5891.1 5921.3 5922.3 5955.9 6101.4 6305.0 6307.5 6310.9 6323.1 4830.9 5845.6 5892.8 5950.6 5986.1 4484.9 5467.9 5473.1 5476.9 5485.2 6226.8 6404.9 6465.7 6473.9 6477.1 4967.0 5123.7 5266.0 6087.4 6137.7 5248.4 6301.8 6316.4 6350.2 6367.9 5329.8 6093.7 6178.7 6199.8 6204.3 5586.2 5594.8 5626.0 5696.9 6217.4 6138.9 6146.0 6192.0 6212.2 6231.8 5972.3 6148.1 6154.6 6162.5 6170.6 5865.7 6009.9 6048.8 6083.0 6126.6 5032.7 6139.6 6149.9 6155.6 6178.5 5583.9 5979.9 5991.8 5991.9 5995.2 20:04:09 INFO - PROCESS | 1927 | 20:04:09 INFO - PROCESS | 1927 | [#1] ext.html Cycles:180 Average:68521.59 Median:39319.30 stddev:153304.01 (389.9%) stddev-sans-first:153648.88 20:04:09 INFO - PROCESS | 1927 | Values: 450.6 473.3 497.0 539.5 573.5 37363.4 39310.0 39328.6 39333.8 39338.2 40356.6 40550.0 40684.0 40734.3 40799.8 9421.7 9639.7 9656.1 9658.9 9683.4 8116.4 9590.9 9625.5 9628.4 9636.5 9640.9 9655.4 9668.2 9670.3 9702.2 8168.8 9605.9 9653.9 9660.8 9664.0 9552.7 9604.0 9606.4 9645.0 9653.7 38641.8 38911.0 38967.2 38990.0 39080.0 3220.0 3260.4 3311.5 3509.0 3756.9 30065.5 30081.7 30623.8 30891.9 31126.8 3168.5 3221.0 3226.6 3227.4 3375.0 455009.0 458295.0 458832.0 462599.7 462973.0 55103.7 55412.2 55413.2 55480.0 55498.0 33102.5 33583.7 33926.7 34849.8 34891.8 16029.8 16123.8 16217.0 16234.1 16254.3 12361.3 12445.9 12456.1 12464.4 12495.3 17820.2 18372.0 18387.9 18464.4 18497.6 6497.1 6670.9 7784.3 7923.0 7947.4 814.9 933.5 944.6 964.7 974.6 23905.0 24237.4 25239.7 29046.7 30122.9 891.3 945.9 975.9 991.2 1092.5 14699.4 15156.9 15160.2 15346.8 15565.5 653650.0 655526.0 661256.5 662094.0 665364.0 55327.2 56294.7 56324.2 56482.7 56680.1 1311.7 1328.0 1349.5 1380.0 1385.8 27428.7 28365.4 28450.0 28916.5 29007.3 46842.1 47115.0 47357.0 47458.3 47514.8 579490.0 580461.0 580699.0 580864.0 581498.0 25008.6 25637.9 25947.2 25960.6 26011.1 44871.8 45650.5 46306.3 46736.1 46897.3 38097.6 38197.6 38221.6 39451.0 39516.4 37528.8 37796.6 37949.1 38751.8 39155.0 36674.4 37545.6 37577.8 37726.6 38078.0 25755.7 31092.8 33518.0 33791.5 34046.1 22506.7 25117.7 25128.5 25421.6 25765.4 20:04:09 INFO - PROCESS | 1927 | 20:04:09 INFO - PROCESS | 1927 | [#2] jquery.html Cycles:180 Average:36777.63 Median:35519.82 stddev:100471.76 (282.9%) stddev-sans-first:100716.39 20:04:09 INFO - PROCESS | 1927 | Values: 357.8 359.8 368.5 376.7 388.0 11724.2 12149.9 12284.8 12293.0 19876.0 21807.8 21941.2 22876.8 23045.4 23080.7 6603.0 6634.9 6946.0 6959.5 6968.8 5824.5 6724.4 6848.0 6888.0 6907.8 6538.5 6763.2 6822.7 6879.3 6880.0 5993.6 6513.0 6770.1 6822.0 6822.7 6533.3 6571.3 6589.4 6593.2 6596.4 28294.7 28977.0 29391.7 29525.4 29647.7 1913.5 2035.5 2157.6 2464.5 3059.8 16210.9 16798.6 17035.0 17048.2 17743.0 1979.2 2024.6 2041.3 2081.3 2082.9 104658.0 106336.4 125964.0 145235.0 152077.0 16307.4 16530.2 19844.0 21051.4 21083.6 34731.0 35401.9 35479.0 35560.6 35656.0 10508.2 10809.5 11016.1 11077.9 11161.3 7297.3 8984.4 8997.0 9148.0 9218.6 9681.3 9757.5 9898.7 9955.0 9968.3 3191.9 3801.8 3814.6 3831.1 3920.3 787.3 888.7 911.0 926.7 939.6 16951.7 17066.2 17491.9 17677.8 19453.4 869.2 876.5 890.9 905.3 928.7 10622.6 11034.9 11053.6 11067.6 11078.9 593123.0 598900.0 602329.0 603524.6 608260.0 109079.0 119081.0 132135.3 136502.3 136888.3 909.3 936.9 957.6 958.3 969.1 15994.0 18611.9 18788.8 18955.3 19197.8 52440.0 57303.7 57489.1 57655.4 58485.0 84048.0 84229.6 85074.0 85415.1 86104.3 6430.7 6751.7 7822.6 8039.4 8140.6 10259.2 12460.8 12551.9 12567.7 12620.9 8601.6 10602.4 10716.8 10895.6 11036.2 9621.6 10404.5 10810.6 10838.8 11042.3 9666.9 10074.8 10895.7 11111.8 11293.0 7366.2 7383.1 7905.7 8038.7 8175.0 10245.3 10868.5 11134.9 11179.9 11258.2 20:04:09 INFO - PROCESS | 1927 | 20:04:09 INFO - PROCESS | 1927 | [#3] mootools.html Cycles:180 Average:5777.58 Median:4796.38 stddev:3279.19 (68.4%) stddev-sans-first:3272.37 20:04:09 INFO - PROCESS | 1927 | Values: 1465.0 1518.4 1749.2 1882.5 1910.2 8123.0 8586.0 8810.7 9184.6 9188.6 8788.3 9013.4 9022.1 9044.4 9057.5 2418.7 2432.0 2432.7 2439.2 2446.0 2005.3 2387.6 2408.6 2421.7 2432.8 2360.8 2370.6 2378.6 2383.6 2389.9 2351.4 2362.1 2388.5 2398.1 2413.5 2374.8 2387.6 2396.8 2403.0 2406.5 9031.6 9104.5 9106.4 9116.5 9126.9 5322.0 5533.8 5535.6 5540.1 5549.6 3572.2 3702.6 3718.8 3770.2 3782.5 1082.5 1087.2 1092.8 1109.6 1111.7 11889.8 11890.0 11922.0 11962.8 12019.6 4429.7 4545.3 4693.9 4701.5 4738.0 9186.0 9283.4 9317.1 9381.7 9406.4 5295.5 5340.5 5344.5 5361.2 5364.7 4468.3 4854.8 4980.0 4992.5 5019.2 3757.0 3822.9 3863.7 3898.0 3924.5 1178.3 1189.6 1194.0 1194.5 1196.2 909.0 924.5 937.6 944.8 945.3 5688.0 5764.2 5926.6 5983.3 6296.9 416.3 423.7 441.7 445.4 451.1 3945.3 4008.6 4090.3 4125.2 4150.9 10813.6 11027.3 11100.4 11167.6 11172.6 10715.5 11091.1 11122.6 11141.7 11158.2 8183.6 8403.6 8463.8 8464.2 8469.6 5094.9 5863.8 5956.7 5998.6 6044.6 8353.5 10289.9 10338.5 10341.6 10392.9 10222.6 10303.8 10335.8 10527.7 10581.6 6494.4 6608.3 7086.4 7193.3 7245.9 8563.7 8566.9 8643.0 8655.3 8677.1 7584.6 7702.6 7706.1 7798.7 7837.8 7401.7 7511.4 7556.1 7581.4 7669.9 7011.5 7096.2 7155.9 7163.0 7189.0 4574.7 4873.3 5049.7 5086.3 5162.5 5086.5 5151.3 5246.9 5259.2 5274.0 20:04:09 INFO - PROCESS | 1927 | 20:04:09 INFO - PROCESS | 1927 | [#4] prototype.html Cycles:180 Average:4384.08 Median:4835.98 stddev:1364.44 (28.2%) stddev-sans-first:1333.40 20:04:09 INFO - PROCESS | 1927 | Values: 300.4 302.5 309.6 314.3 314.5 5302.8 5377.8 5443.8 5502.8 5535.3 4929.4 5372.4 5456.0 5469.2 5496.6 3345.8 3556.8 3629.9 3672.9 4173.6 3152.1 3632.1 3970.3 4210.3 4215.6 3363.7 4123.6 4142.7 4154.6 4159.9 3813.0 3936.9 4154.3 4157.6 4174.7 3603.4 3617.3 3626.9 3636.7 3642.0 4435.7 4558.3 4957.3 5258.5 5322.4 3979.0 4453.2 4770.0 4787.2 4790.3 5080.1 5270.2 5510.4 5530.6 5907.5 3009.4 3401.0 3450.7 3557.8 3858.3 5039.0 5594.3 5805.5 6082.2 6136.5 3260.3 3679.4 3730.5 3829.9 4010.6 3851.2 4073.0 4100.4 4108.3 4119.9 3966.7 4680.1 4688.3 4802.8 4810.5 5293.3 5782.8 5843.8 5868.5 5871.9 1321.3 1374.0 1374.8 1389.5 1396.1 886.0 910.3 920.0 931.6 955.9 4676.2 4817.3 4921.1 5298.7 5347.5 5770.2 5795.7 5856.9 5895.6 5901.9 4411.0 4674.2 5312.3 5337.3 5395.5 2290.7 2310.0 2383.8 2541.8 2589.9 4207.7 4445.9 5187.9 5203.5 5244.0 4270.8 4626.1 4670.7 5002.6 5089.7 4166.4 4616.0 4989.9 5154.9 5165.5 4700.7 4907.6 4911.5 4944.6 4973.5 4574.1 4761.2 4855.5 4866.7 4901.0 4618.0 5106.7 5143.9 5145.7 5194.5 3045.3 3401.3 3406.6 3493.0 3504.4 4074.9 4782.8 4862.8 4907.8 5099.9 5345.7 5684.9 5781.1 5811.7 5832.2 5028.6 5797.1 5839.6 5850.9 5858.9 4306.6 4756.4 5073.5 5503.2 5724.5 4854.6 5885.3 5919.5 5941.0 5971.3 4988.0 5100.3 5271.9 5788.8 5794.0 20:04:09 INFO - PROCESS | 1927 | 20:04:09 INFO - PROCESS | 1927 | [#5] yui.html Cycles:180 Average:24835.30 Median:3756.81 stddev:39907.69 (1062.3%) stddev-sans-first:39978.45 20:04:09 INFO - PROCESS | 1927 | Values: 687.6 702.0 703.7 752.4 825.4 15374.3 15953.8 16129.9 16211.4 16250.8 14572.3 15158.4 15759.6 15898.6 16208.0 818.7 843.9 847.2 849.1 849.5 672.6 819.0 838.6 844.1 846.7 900.6 901.9 901.9 902.1 903.7 879.2 896.1 897.9 898.5 899.2 644.7 645.4 663.2 667.9 670.0 15464.0 15468.3 15468.8 15479.9 15480.0 10670.5 10879.7 12242.6 12348.4 14159.2 9749.9 11611.0 11755.4 11841.5 11953.0 3733.9 3748.3 3764.4 3782.4 3791.8 86791.0 113777.0 116639.7 119076.4 119577.0 10653.6 10756.2 10758.4 10821.5 11197.6 22282.3 22322.3 22364.6 22364.6 22441.0 7660.7 7816.1 7826.6 7911.4 8016.0 4305.2 4432.7 4436.6 4437.3 4446.9 3474.7 3564.6 3590.9 3592.3 3749.3 593.2 656.3 705.3 714.3 729.2 554.4 580.5 634.2 667.8 675.2 9040.3 9072.7 9367.3 9478.9 9669.6 562.9 638.2 649.5 662.3 669.5 4366.9 4436.2 4536.8 4549.9 4646.8 84409.8 155783.4 157592.6 158429.2 158953.0 111115.0 135384.6 136777.0 136802.0 138585.0 98161.5 118209.4 121913.0 122552.0 123231.0 8820.3 8843.3 8851.6 8908.0 8954.0 52879.0 61238.5 63767.7 67089.7 67814.7 79608.0 81821.0 86100.6 86569.0 86935.6 13221.5 13281.3 13297.5 13582.7 13602.3 14417.2 14447.5 14672.4 14838.9 14960.6 13697.4 13825.8 13863.0 14100.4 14445.0 13496.1 13849.2 14070.5 14121.7 14375.0 13565.1 13845.9 13964.0 14180.4 14282.9 10983.8 11049.9 11248.3 11511.2 11667.9 9050.5 9713.5 10976.6 11358.1 11664.4 20:04:09 INFO - PROCESS | 1927 | -------- Summary: end -------- 20:04:09 INFO - PROCESS | 1927 | 20:04:10 INFO - TEST-INFO | 1927: exit 0 20:04:10 INFO - TEST-OK | dromaeo_css | took 1114345ms 20:04:10 INFO - TEST-START | kraken 20:04:10 INFO - operating with platform_type : mac_ 20:04:10 INFO - Initialising browser for kraken test... 20:04:10 INFO - TEST-INFO | started process 1933 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmpd1cfGe/profile http://localhost:51502/getInfo.html) 20:04:13 INFO - PROCESS | 1933 | __metrics Screen width/height:1600/1200 20:04:13 INFO - PROCESS | 1933 | colorDepth:24 20:04:13 INFO - PROCESS | 1933 | Browser inner width/height: 1024/689 20:04:13 INFO - PROCESS | 1933 | __metrics 20:04:13 ERROR - PROCESS | 1933 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 20:04:13 INFO - TEST-INFO | 1933: exit 0 20:04:13 INFO - Browser initialized. 20:04:13 INFO - Running cycle 1/1 for kraken test... 20:04:13 INFO - TEST-INFO | started process 1935 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmpd1cfGe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:04:25 INFO - PROCESS | 1935 | RSS: Main: 243773440 20:04:25 INFO - PROCESS | 1935 | 20:04:28 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:51502/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51502/tests/kraken/driver.html?testName=audio-beat-detection) 20:04:29 INFO - PROCESS | 1935 | RSS: Main: 256770048 20:04:29 INFO - PROCESS | 1935 | 20:04:32 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:51502/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51502/tests/kraken/driver.html?testName=audio-dft) 20:04:33 INFO - PROCESS | 1935 | RSS: Main: 265342976 20:04:33 INFO - PROCESS | 1935 | 20:04:36 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:51502/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51502/tests/kraken/driver.html?testName=audio-fft) 20:04:37 INFO - PROCESS | 1935 | RSS: Main: 262049792 20:04:37 INFO - PROCESS | 1935 | 20:04:39 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:51502/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51502/tests/kraken/driver.html?testName=audio-oscillator) 20:04:39 INFO - PROCESS | 1935 | RSS: Main: 263282688 20:04:39 INFO - PROCESS | 1935 | 20:04:41 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:51502/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51502/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:04:42 INFO - PROCESS | 1935 | RSS: Main: 263643136 20:04:42 INFO - PROCESS | 1935 | 20:04:45 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:51502/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51502/tests/kraken/driver.html?testName=imaging-darkroom) 20:04:46 INFO - PROCESS | 1935 | RSS: Main: 265474048 20:04:46 INFO - PROCESS | 1935 | 20:04:49 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:51502/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51502/tests/kraken/driver.html?testName=imaging-desaturate) 20:04:50 INFO - PROCESS | 1935 | RSS: Main: 266887168 20:04:50 INFO - PROCESS | 1935 | 20:04:53 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:51502/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51502/tests/kraken/driver.html?testName=json-parse-financial) 20:04:53 INFO - PROCESS | 1935 | RSS: Main: 266801152 20:04:53 INFO - PROCESS | 1935 | 20:04:55 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:51502/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51502/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:04:56 INFO - PROCESS | 1935 | RSS: Main: 266723328 20:04:56 INFO - PROCESS | 1935 | 20:04:58 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:51502/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51502/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:04:58 INFO - PROCESS | 1935 | RSS: Main: 266326016 20:04:58 INFO - PROCESS | 1935 | 20:05:01 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:51502/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51502/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:05:01 INFO - PROCESS | 1935 | RSS: Main: 266387456 20:05:01 INFO - PROCESS | 1935 | 20:05:04 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:51502/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:05:05 INFO - PROCESS | 1935 | RSS: Main: 266469376 20:05:05 INFO - PROCESS | 1935 | 20:05:08 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:51502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:05:09 INFO - PROCESS | 1935 | RSS: Main: 266448896 20:05:09 INFO - PROCESS | 1935 | 20:05:10 INFO - PROCESS | 1935 | Cycle 1(1): loaded http://localhost:51502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51502/tests/kraken/driver.html?testName=ai-astar) 20:05:11 INFO - PROCESS | 1935 | RSS: Main: 268582912 20:05:11 INFO - PROCESS | 1935 | 20:05:11 INFO - PROCESS | 1935 | __start_tp_report 20:05:11 INFO - PROCESS | 1935 | _x_x_mozilla_page_load 20:05:11 INFO - PROCESS | 1935 | _x_x_mozilla_page_load_details 20:05:11 INFO - PROCESS | 1935 | |i|pagename|runs| 20:05:11 INFO - PROCESS | 1935 | |0;ai-astar;122;110;95;173;172;110;124;172;116;118 20:05:11 INFO - PROCESS | 1935 | |1;audio-beat-detection;145;113;134;162;111;131;132;113;162;114 20:05:11 INFO - PROCESS | 1935 | |2;audio-dft;204;217;226;263;283;209;200;206;197;194 20:05:11 INFO - PROCESS | 1935 | |3;audio-fft;72;86;79;140;63;71;60;66;134;58 20:05:11 INFO - PROCESS | 1935 | |4;audio-oscillator;71;75;116;73;74;95;104;92;99;148 20:05:11 INFO - PROCESS | 1935 | |5;imaging-gaussian-blur;99;89;131;128;92;88;128;97;78;130 20:05:11 INFO - PROCESS | 1935 | |6;imaging-darkroom;99;129;166;169;101;148;102;106;135;171 20:05:11 INFO - PROCESS | 1935 | |7;imaging-desaturate;90;95;90;92;94;104;151;152;91;93 20:05:11 INFO - PROCESS | 1935 | |8;json-parse-financial;46;52;81;55;63;64;52;56;61;89 20:05:11 INFO - PROCESS | 1935 | |9;json-stringify-tinderbox;68;73;76;71;93;97;100;74;69;73 20:05:11 INFO - PROCESS | 1935 | |10;stanford-crypto-aes;91;85;103;80;92;101;100;82;108;112 20:05:11 INFO - PROCESS | 1935 | |11;stanford-crypto-ccm;142;140;139;140;142;145;149;162;194;150 20:05:11 INFO - PROCESS | 1935 | |12;stanford-crypto-pbkdf2;170;177;173;172;177;173;170;249;234;181 20:05:11 INFO - PROCESS | 1935 | |13;stanford-crypto-sha256-iterative;67;68;75;79;91;87;91;92;79;69 20:05:11 INFO - PROCESS | 1935 | __end_tp_report 20:05:11 INFO - PROCESS | 1935 | __start_cc_report 20:05:11 INFO - PROCESS | 1935 | _x_x_mozilla_cycle_collect,987 20:05:11 INFO - PROCESS | 1935 | __end_cc_report 20:05:11 INFO - PROCESS | 1935 | __startTimestamp1472612711184__endTimestamp 20:05:11 INFO - PROCESS | 1935 | 20:05:11 INFO - PROCESS | 1935 | ------- Summary: start ------- 20:05:11 INFO - PROCESS | 1935 | Number of tests: 14 20:05:11 INFO - PROCESS | 1935 | 20:05:11 INFO - PROCESS | 1935 | [#0] ai-astar Cycles:10 Average:131.20 Median:148.00 stddev:29.49 (19.9%) stddev-sans-first:31.09 20:05:11 INFO - PROCESS | 1935 | Values: 122.0 110.0 95.0 173.0 172.0 110.0 124.0 172.0 116.0 118.0 20:05:11 INFO - PROCESS | 1935 | 20:05:11 INFO - PROCESS | 1935 | [#1] audio-beat-detection Cycles:10 Average:131.70 Median:133.00 stddev:19.61 (14.7%) stddev-sans-first:20.20 20:05:11 INFO - PROCESS | 1935 | Values: 145.0 113.0 134.0 162.0 111.0 131.0 132.0 113.0 162.0 114.0 20:05:11 INFO - PROCESS | 1935 | 20:05:11 INFO - PROCESS | 1935 | [#2] audio-dft Cycles:10 Average:219.90 Median:213.00 stddev:29.89 (14.0%) stddev-sans-first:31.14 20:05:11 INFO - PROCESS | 1935 | Values: 204.0 217.0 226.0 263.0 283.0 209.0 200.0 206.0 197.0 194.0 20:05:11 INFO - PROCESS | 1935 | 20:05:11 INFO - PROCESS | 1935 | [#3] audio-fft Cycles:10 Average:82.90 Median:68.50 stddev:29.78 (43.5%) stddev-sans-first:31.33 20:05:11 INFO - PROCESS | 1935 | Values: 72.0 86.0 79.0 140.0 63.0 71.0 60.0 66.0 134.0 58.0 20:05:11 INFO - PROCESS | 1935 | 20:05:11 INFO - PROCESS | 1935 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:74.50 stddev:24.17 (32.4%) stddev-sans-first:24.06 20:05:11 INFO - PROCESS | 1935 | Values: 71.0 75.0 116.0 73.0 74.0 95.0 104.0 92.0 99.0 148.0 20:05:11 INFO - PROCESS | 1935 | 20:05:11 INFO - PROCESS | 1935 | [#5] imaging-gaussian-blur Cycles:10 Average:106.00 Median:88.50 stddev:20.80 (23.5%) stddev-sans-first:21.90 20:05:11 INFO - PROCESS | 1935 | Values: 99.0 89.0 131.0 128.0 92.0 88.0 128.0 97.0 78.0 130.0 20:05:11 INFO - PROCESS | 1935 | 20:05:11 INFO - PROCESS | 1935 | [#6] imaging-darkroom Cycles:10 Average:132.60 Median:157.00 stddev:29.71 (18.9%) stddev-sans-first:28.91 20:05:11 INFO - PROCESS | 1935 | Values: 99.0 129.0 166.0 169.0 101.0 148.0 102.0 106.0 135.0 171.0 20:05:11 INFO - PROCESS | 1935 | 20:05:11 INFO - PROCESS | 1935 | [#7] imaging-desaturate Cycles:10 Average:105.20 Median:91.50 stddev:24.73 (27.0%) stddev-sans-first:25.61 20:05:11 INFO - PROCESS | 1935 | Values: 90.0 95.0 90.0 92.0 94.0 104.0 151.0 152.0 91.0 93.0 20:05:11 INFO - PROCESS | 1935 | 20:05:11 INFO - PROCESS | 1935 | [#8] json-parse-financial Cycles:10 Average:61.90 Median:62.00 stddev:13.49 (21.8%) stddev-sans-first:13.02 20:05:11 INFO - PROCESS | 1935 | Values: 46.0 52.0 81.0 55.0 63.0 64.0 52.0 56.0 61.0 89.0 20:05:11 INFO - PROCESS | 1935 | 20:05:11 INFO - PROCESS | 1935 | [#9] json-stringify-tinderbox Cycles:10 Average:79.40 Median:73.50 stddev:12.25 (16.7%) stddev-sans-first:12.28 20:05:11 INFO - PROCESS | 1935 | Values: 68.0 73.0 76.0 71.0 93.0 97.0 100.0 74.0 69.0 73.0 20:05:11 INFO - PROCESS | 1935 | 20:05:11 INFO - PROCESS | 1935 | [#10] stanford-crypto-aes Cycles:10 Average:95.40 Median:81.00 stddev:11.06 (13.7%) stddev-sans-first:11.61 20:05:11 INFO - PROCESS | 1935 | Values: 91.0 85.0 103.0 80.0 92.0 101.0 100.0 82.0 108.0 112.0 20:05:11 INFO - PROCESS | 1935 | 20:05:11 INFO - PROCESS | 1935 | [#11] stanford-crypto-ccm Cycles:10 Average:150.30 Median:147.00 stddev:16.85 (11.5%) stddev-sans-first:17.60 20:05:11 INFO - PROCESS | 1935 | Values: 142.0 140.0 139.0 140.0 142.0 145.0 149.0 162.0 194.0 150.0 20:05:11 INFO - PROCESS | 1935 | 20:05:11 INFO - PROCESS | 1935 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.60 Median:177.00 stddev:28.83 (16.3%) stddev-sans-first:29.87 20:05:11 INFO - PROCESS | 1935 | Values: 170.0 177.0 173.0 172.0 177.0 173.0 170.0 249.0 234.0 181.0 20:05:11 INFO - PROCESS | 1935 | 20:05:11 INFO - PROCESS | 1935 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.80 Median:83.00 stddev:9.98 (12.0%) stddev-sans-first:9.44 20:05:11 INFO - PROCESS | 1935 | Values: 67.0 68.0 75.0 79.0 91.0 87.0 91.0 92.0 79.0 69.0 20:05:11 INFO - PROCESS | 1935 | -------- Summary: end -------- 20:05:11 INFO - PROCESS | 1935 | 20:05:12 INFO - TEST-INFO | 1935: exit 0 20:05:12 INFO - TEST-OK | kraken | took 61802ms 20:05:12 INFO - SUITE-END | took 1176s 20:05:12 INFO - Completed test suite (00:19:36) 20:05:12 INFO - javascript benchmark 20:05:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7386.217530019553, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3410.931781364373, 3448.413769659158, 3473.287975964926, 3482.3383557124143, 3487.250241198142, 5661.8584535386635, 5755.25181726375, 5761.913571296429, 5761.942380576198, 5843.970780146104, 4710.505396933324, 5716.657000579969, 5725.513331366828, 5725.828225153242, 5755.482006619403, 5140.074786538422, 5148.588112950955, 5213.504717051893, 5223.921641175385, 5296.364436267634, 4816.855494335158, 5116.925445656417, 5197.324347834776, 5330.173823057432, 5360.517553420192, 5164.328637277167, 5172.637915345908, 5239.266502689627, 5276.709780962045, 5338.199270109476, 5257.605679574047, 5268.92096618551, 5276.393214780311, 5283.788648454057, 5286.07493688603, 5197.376314842205, 5253.789848406059, 5272.710000949946, 5293.57651387888, 5298.92051619226, 4638.327442520816, 5493.121100623881, 5727.885442291131, 5747.453991870766, 5761.539076873882, 6112.449879510821, 6197.783077592308, 6217.658028808413, 6231.0, 6237.126802247689, 6245.422066759335, 6285.0, 6295.150154729099, 6297.811065668037, 6327.398897104814, 5680.971595142039, 5764.798232061858, 5766.933117373257, 5784.739686714108, 5805.187273781674, 6236.563440559208, 6247.468965138014, 6289.245290565162, 6292.433680968643, 6348.04779283102, 6166.599171053867, 6222.657753823492, 6226.0, 6229.875402491924, 6231.844203894939, 6073.180120683651, 6251.281102673251, 6264.718087686065, 6287.056941458726, 6308.621482711052, 6137.622145770991, 6191.0, 6221.968890155611, 6258.812235632939, 6266.216722909637, 6234.501239900797, 6265.122882796412, 6287.874242515124, 6294.811155665246, 6308.8422789429715, 4300.440942677432, 4844.32179494871, 4886.95113048865, 4917.7786999585105, 4987.226979818134, 4418.756968366706, 4426.402435671208, 4478.149151661174, 4485.865424037284, 4487.237169681162, 5814.156947242626, 5891.1457838614015, 5921.289445266596, 5922.2597175353085, 5955.910661340084, 6101.429060711456, 6305.0, 6307.495400368051, 6310.9368906311265, 6323.146375239376, 4830.855074347775, 5845.649261044351, 5892.793752218652, 5950.583459157818, 5986.07215881539, 4484.865454036384, 5467.917981230285, 5473.124300111963, 5476.91784623231, 5485.204645326406, 6226.782062627786, 6404.871902561923, 6465.741370345134, 6473.8705225896165, 6477.060826180272, 4966.956939042841, 5123.692578445305, 5265.973670131625, 6087.391260874055, 6137.714085983886, 5248.396434409939, 6301.842453938505, 6316.431521163117, 6350.206224221973, 6367.93632063692, 5329.760160792696, 6093.664848433202, 6178.69106544662, 6199.814005579839, 6204.317525072329, 5586.190002449704, 5594.797118619516, 5625.987322282029, 5696.943030569641, 6217.409346112112, 6138.9095594588325, 6146.047362658616, 6192.040233763774, 6212.161358216583, 6231.813045608639, 5972.25346831646, 6148.077788331786, 6154.569180157346, 6162.506999440124, 6170.568060235741, 5865.677387743544, 6009.939900600938, 6048.848778780566, 6083.026715725463, 6126.6017708848785, 5032.723200224023, 6139.6009259398, 6149.877002460015, 6155.569110162425, 6178.474829639351, 5583.916241256303, 5979.850503737442, 5991.7902873399225, 5991.940080599138, 5995.1906492624685], "value": 5663.872661023028, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [450.58546137553446, 473.27825066773187, 496.95278948499885, 539.514437006694, 573.5239751006665, 37363.43954840679, 39310.0, 39328.60671393285, 39333.80333098334, 39338.21323573527, 40356.59643403565, 40549.98625034368, 40684.0, 40734.29719839225, 40799.796001020026, 9421.71734847954, 9639.71080867575, 9656.130948214659, 9658.903410965906, 9683.41899486033, 8116.431849770489, 9590.856137157949, 9625.470599117045, 9628.35220314412, 9636.469994150319, 9640.903590964072, 9655.372400793962, 9668.226541876667, 9670.323077384586, 9702.22382209425, 8168.836623267561, 9605.886704924906, 9653.855192172088, 9660.806783864284, 9664.0, 9552.713418597454, 9604.0, 9606.423614583147, 9645.0, 9653.662121825773, 38641.80679096615, 38911.02722431933, 38967.22065558673, 38990.0, 39080.0, 3219.9517007244676, 3260.3805276997296, 3311.503274508819, 3508.9649103508896, 3756.9248615027545, 30065.549016764766, 30081.69918300811, 30623.846880765675, 30891.91878284249, 31126.84436577825, 3168.5088811234295, 3220.951685724716, 3226.6450690424035, 3227.3706627207703, 3375.0, 455009.0, 458295.0, 458832.0, 462599.6870015662, 462973.0, 55103.724481377336, 55412.16881746777, 55413.168802468, 55480.0, 55498.0, 33102.5311582938, 33583.664163358546, 33926.66073339235, 34849.82575087108, 34891.82554087213, 16029.759553606706, 16123.83876161247, 16217.026978381335, 16234.107124108288, 16254.268557914922, 12361.258324500379, 12445.937770311091, 12456.128071035122, 12464.376781160905, 12495.312757798227, 17820.19809108593, 18372.0, 18387.89672619647, 18464.446066618024, 18497.630047398976, 6497.122888410004, 6670.898666920002, 7784.338331241795, 7923.009623797026, 7947.3642108631175, 814.9266566009088, 933.4772527384687, 944.5513381143902, 964.7154089543601, 974.6296407365156, 23905.04379824822, 24237.394065148514, 25239.74760252411, 29046.692898819605, 30122.945696900504, 891.3092353426017, 945.9054094590623, 975.9072888075622, 991.1872264742842, 1092.4865313302735, 14699.41202351894, 15156.924215378853, 15160.241987900561, 15346.846531534542, 15565.455209067628, 653650.0, 655526.0, 661256.5497380147, 662094.0, 665364.0, 55327.17009244864, 56294.71852640711, 56324.15513767297, 56482.7175864118, 56680.14979775307, 1311.6917524381763, 1327.9601611951657, 1349.4602159136227, 1380.0339762166523, 1385.7505648983079, 27428.67927527015, 28365.432691346472, 28450.0, 28916.542093922253, 29007.274818129714, 46842.06315873595, 47115.0, 47357.0, 47458.28812567883, 47514.76242618765, 579490.0, 580461.0, 580699.0, 580864.0, 581498.0, 25008.623835781935, 25637.871810640827, 25947.22158335253, 25960.610590840774, 26011.089611863496, 44871.77564112289, 45650.54349456463, 46306.30540541827, 46736.065278694914, 46897.29654055124, 38097.61902381052, 38197.61802381941, 38221.61778382292, 39451.0, 39516.40725389179, 37528.81235593805, 37796.62203377931, 37949.051273718374, 38751.806240969745, 39155.0, 36674.44988325231, 37545.62454375421, 37577.81211093927, 37726.62273377231, 38078.0, 25755.742442575334, 31092.844535777178, 33518.0, 33791.49312760261, 34046.148846279044, 22506.662400063684, 25117.74882251154, 25128.497430051662, 25421.61867572025, 25765.3558661035], "value": 19146.80420640654, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.787116665584, 359.8326778048207, 368.4565266232308, 376.6741768370357, 387.9641357575274, 11724.179307448472, 12149.878501214986, 12284.815727764068, 12293.0, 19876.00619969003, 21807.781922180773, 21941.232056878012, 22876.771232287672, 23045.423864403398, 23080.65379019316, 6602.9669851650915, 6634.933650663504, 6946.027556142144, 6959.478039147059, 6968.825779355531, 5824.475797178253, 6724.428423584001, 6847.965760171192, 6888.0, 6907.758228462005, 6538.509611779112, 6763.222229443628, 6822.6929788159405, 6879.27767584404, 6880.0, 5993.610415323012, 6512.967435162841, 6770.0860383848285, 6821.965890170567, 6822.692978815965, 6533.314002029766, 6571.342865713438, 6589.385600527853, 6593.241777195636, 6596.43930265928, 28294.71705282962, 28977.0, 29391.677374518196, 29525.40949181004, 29647.70352296471, 1913.473794706453, 2035.5013021809752, 2157.6332023555874, 2464.5440593490084, 3059.816411015346, 16210.94138967993, 16798.58003549909, 17034.955805303318, 17048.2328295227, 17743.0, 1979.2478858033999, 2024.595080983809, 2041.3467690339098, 2081.2819577245828, 2082.9479263018393, 104658.0, 106336.40495392575, 125964.0, 145235.0, 152077.0, 16307.429239976544, 16530.173491325386, 19844.0, 21051.368458946257, 21083.578328433345, 34731.0, 35401.93794186178, 35479.0, 35560.64439355573, 35656.0, 10508.159347252202, 10809.459527023775, 11016.06363459115, 11077.889221107847, 11161.274517156358, 7297.343239108506, 8984.416012959136, 8997.0, 9148.0, 9218.58516366765, 9681.273904457194, 9757.463339516253, 9898.653547125816, 9954.950225248827, 9968.302218844612, 3191.856366463515, 3801.790901500444, 3814.6376094271, 3831.1188426662025, 3920.3335432976464, 787.338635546144, 888.6625628429173, 910.9544522773834, 926.7173512078881, 939.6241503398695, 16951.728620353522, 17066.2320195589, 17491.91254043747, 17677.823221767874, 19453.416397507815, 869.1786261982365, 876.4784952952983, 890.8797312362748, 905.2712566384124, 928.7028150991753, 10622.628208012682, 11034.889651103547, 11053.613123540637, 11067.557297708163, 11078.944605276922, 593123.0, 598900.0, 602329.0, 603524.5520015026, 608260.0, 109079.0, 119081.0, 132135.33932330276, 136502.31748841392, 136888.31555842157, 909.30892521684, 936.9250459963187, 957.5834511987308, 958.324381311174, 969.0890562870878, 15994.0, 18611.90694046521, 18788.81211187925, 18955.336563220222, 19197.808021920162, 52440.0, 57303.71348143233, 57489.137662934256, 57655.423445765, 58485.0, 84048.0, 84229.57885210535, 85074.0, 85415.14584854072, 86104.27791444011, 6430.710618022294, 6751.662416879235, 7822.608869556613, 8039.356851451753, 8140.59297035134, 10259.17926565858, 12460.813087803508, 12551.87448125507, 12567.66956756442, 12620.936895315464, 8601.612927418406, 10602.416867072385, 10716.839247411139, 10895.564177432814, 11036.227464077438, 9621.56702948383, 10404.531796069346, 10810.621628242974, 10838.837417438586, 11042.282251653616, 9666.888307844687, 10074.798504030025, 10895.727606809893, 11111.777764444827, 11293.0, 7366.189719130998, 7383.07711536058, 7905.723299684483, 8038.718644847402, 8174.959125204336, 10245.334053286513, 10868.456577171268, 11134.944325278322, 11179.888201117885, 11258.21192516516], "value": 10638.478036321787, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1464.9853501464984, 1518.3601710153036, 1749.247823435922, 1882.548188434776, 1910.245453046046, 8123.0, 8586.0, 8810.735677929672, 9184.632614695412, 9188.632454701812, 8788.252998495136, 9013.41412808167, 9022.097790220974, 9044.3668943174, 9057.456552606849, 2418.7097548294228, 2431.987840060797, 2432.659427680126, 2439.2194497760725, 2446.00936620668, 2005.2680771518365, 2387.617981123021, 2408.614621660535, 2421.7336093029753, 2432.781049705526, 2360.8465449745713, 2370.5851475991717, 2378.5718570657273, 2383.6424536319605, 2389.940251493709, 2351.4356554426986, 2362.078789272185, 2388.5461762265113, 2398.0527691561824, 2413.54142712884, 2374.833761636686, 2387.594109001474, 2396.760323967607, 2402.9519409611885, 2406.4946361264156, 9031.638734450615, 9104.499252541107, 9106.40808347462, 9116.498592577405, 9126.863097053549, 5322.0, 5533.750981205855, 5535.557155427597, 5540.085885828834, 5549.5837812163845, 3572.1962558424407, 3702.5556933167923, 3718.7768733876055, 3770.170562476251, 3782.470454136396, 1082.5290998415635, 1087.190043417651, 1092.847001419794, 1109.5617231193633, 1111.744298811278, 11889.821652675217, 11890.048796096291, 11922.046236301076, 11962.760744785142, 12019.579314723942, 4429.712068715523, 4545.272756358967, 4693.882652933704, 4701.506341834127, 4737.976310118427, 9186.0, 9283.39657922233, 9317.11487408695, 9381.718548443558, 9406.43561386319, 5295.470452954673, 5340.546053585489, 5344.545713614386, 5361.222622719683, 5364.678119312854, 4468.262736648417, 4854.781534830941, 4979.975100124476, 4992.500749924979, 5019.247112933089, 3757.0043938356357, 3822.9235415291537, 3863.6715879150024, 3897.980510097488, 3924.4898163238595, 1178.3048001679051, 1189.5717541684987, 1193.958211462612, 1194.510250797169, 1196.1806162778526, 908.9636414543477, 924.4869097650734, 937.554661535765, 944.8110377924443, 945.2823133491213, 5687.971560142173, 5764.221830052973, 5926.614770039933, 5983.252093488314, 6296.905546416808, 416.26113648274554, 423.69282270353744, 441.6731618602211, 445.4476449202965, 451.109059607273, 3945.3292940200236, 4008.6191811777835, 4090.3046482098116, 4125.154343359604, 4150.8547200848425, 10813.56745730162, 11027.283226590245, 11100.44497775108, 11167.609133680282, 11172.553097876156, 10715.46422678863, 11091.112710983101, 11122.610708625321, 11141.721456963478, 11158.218924675357, 8183.63173657175, 8403.579821008925, 8463.830723385498, 8464.195901389481, 8469.618867150994, 5094.898102038012, 5863.765449381977, 5956.731947062479, 5998.580099393001, 6044.57687961856, 8353.498790072616, 10289.9485502572, 10338.483075846027, 10341.63804266847, 10392.948035259775, 10222.591096356062, 10303.793924121626, 10335.844962325722, 10527.684169474927, 10581.576736930436, 6494.447971922251, 6608.273089960197, 7086.433085353056, 7193.280671932765, 7245.855082898418, 8563.743087707378, 8566.91433085661, 8642.956785216034, 8655.264302534104, 8677.088905664814, 7584.620768961419, 7702.576358300347, 7706.113796913202, 7798.688052477837, 7837.7648670539975, 7401.740939067106, 7511.399088073051, 7556.1310449299035, 7581.431392645684, 7669.923300766921, 7011.544249623758, 7096.183938847099, 7155.892661609976, 7163.0, 7188.964055179691, 4574.748388838646, 4873.293372461044, 5049.747512624281, 5086.262491938722, 5162.457941916045, 5086.516780905956, 5151.304573882478, 5246.921296180637, 5259.237410575522, 5273.973630131824], "value": 4552.108275230013, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.3632299525007, 302.53258715284886, 309.61143764575456, 314.27402699763536, 314.54077047510634, 5302.787888484456, 5377.8117765878205, 5443.836684899455, 5502.779888804448, 5535.308086489194, 4929.383827021622, 5372.382176049746, 5456.0, 5469.249840051185, 5496.560275177986, 3345.7825241359296, 3556.76881002734, 3629.909252268701, 3672.889813305592, 4173.582641735818, 3152.148919791655, 3632.1101330174142, 3970.260520241039, 4210.305299625558, 4215.557366476522, 3363.663633636629, 4123.5876412358675, 4142.730722503043, 4154.646855017327, 4159.854405095823, 3812.9514383544747, 3936.933110117183, 4154.293770059097, 4157.584241575833, 4174.660271782592, 3603.351396748584, 3617.276544691072, 3626.9274614507826, 3636.7454278200535, 3642.0, 4435.733855968652, 4558.316252562142, 4957.330760347343, 5258.526732594047, 5322.414534401213, 3978.9801050994847, 4453.198424283628, 4769.952300476985, 4787.234042553209, 4790.305405716152, 5080.060188865072, 5270.235815806686, 5510.421405752419, 5530.617345663584, 5907.497862681677, 3009.3529891073526, 3401.0, 3450.706689931359, 3557.804320762357, 3858.2862170498547, 5038.974805125951, 5594.328680558318, 5805.477507024388, 6082.178905847698, 6136.527233463981, 3260.347930413927, 3679.392900171442, 3730.4590834329415, 3829.923401531954, 4010.578889216649, 3851.171998020383, 4072.9796351018053, 4100.36444351126, 4108.342665173617, 4119.8970025748995, 3966.7024973126554, 4680.134175177603, 4688.343631891538, 4802.84731664398, 4810.494898035726, 5293.285406470077, 5782.797602083907, 5843.766249349978, 5868.471837534642, 5871.853203669943, 1321.2799024531653, 1374.0244426457127, 1374.8281464816898, 1389.4789453954768, 1396.1483495068, 885.9988213318908, 910.3081657940013, 919.9586018629178, 931.6133804471204, 955.8996305387973, 4676.18166820805, 4817.349657796222, 4921.138800709861, 5298.7350632469, 5347.5294294069445, 5770.2498675171955, 5795.710214489259, 5856.862245280442, 5895.587308888336, 5901.911471327933, 4411.005677532078, 4674.247157316006, 5312.335958005249, 5337.306150200449, 5395.489263006364, 2290.7365652949793, 2310.0297874892585, 2383.8212134090013, 2541.8474891506567, 2589.9352516187246, 4207.726497777635, 4445.911081778347, 5187.948120518822, 5203.479652034766, 5244.0, 4270.839578711793, 4626.0608939669155, 4670.673052886265, 5002.59979201663, 5089.745512724349, 4166.41670166183, 4615.976920115378, 4989.850304490871, 5154.9174673318275, 5165.48345165488, 4700.694454860423, 4907.582855457326, 4911.533404326583, 4944.629152813482, 4973.518537024025, 4574.124608910331, 4761.166950723927, 4855.514448555116, 4866.732329721899, 4901.0, 4617.976910115428, 5106.693598384109, 5143.92284115731, 5145.713571607098, 5194.454582268807, 3045.3151686458746, 3401.2857299967286, 3406.642302558295, 3492.9825350873084, 3504.4392897136336, 4074.8777536673947, 4782.760861956818, 4862.781174847211, 4907.822122690457, 5099.87250318745, 5345.679259244303, 5684.9431505684415, 5781.121135630852, 5811.651300921958, 5832.183494310885, 5028.59771218309, 5797.130430435468, 5839.5912286141265, 5850.899023517542, 5858.882822343615, 4306.633936115465, 4756.405449318835, 5073.492650734897, 5503.174523821459, 5724.542036637143, 4854.611631069577, 5885.293764748087, 5919.467247947706, 5940.960331941979, 5971.313298970674, 4987.977464619817, 5100.285959965534, 5271.920921186109, 5788.829189054105, 5793.971030144822], "value": 3962.3179591927155, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.573704303332, 701.9824504387393, 703.70092710598, 752.4281546025023, 825.4304529874388, 15374.308156132973, 15953.84046159538, 16129.919350403261, 16211.432599859007, 16250.756238656415, 14572.344244508997, 15158.393664253417, 15759.60600984976, 15898.602534936603, 16208.027518348907, 818.6929901287017, 843.8818565400849, 847.1824689174945, 849.0702680564772, 849.5115308697524, 672.5897202706345, 818.9754307370788, 838.6477679374647, 844.0968164064423, 846.724814435308, 900.6487469886749, 901.923336516397, 901.9323550733722, 902.0888902208784, 903.7153296711548, 879.2218886285651, 896.0680891872478, 897.869808877709, 898.5417437107089, 899.2356496977582, 644.7485480662546, 645.3610925184034, 663.1842833315002, 667.9064930909676, 670.0184230102923, 15464.0, 15468.303926323342, 15468.76796848037, 15479.922600386926, 15480.0, 10670.466476676213, 10879.728006799893, 12242.571509997197, 12348.38258087101, 14159.22124283164, 9749.853752193723, 11611.0, 11755.35345555994, 11841.467133978991, 11953.043756499459, 3733.9439908401396, 3748.269087527933, 3764.360058789985, 3782.413725872494, 3791.7724936503896, 86791.0, 113777.0, 116639.66720665625, 119076.40461797723, 119577.0, 10653.573857045787, 10756.193285503463, 10758.354498730101, 10821.513031913426, 11197.608083717194, 22282.331530054125, 22322.330330090124, 22364.55270894573, 22364.55270894573, 22441.0, 7660.693572257159, 7816.10114836801, 7826.647800848861, 7911.406644501571, 8016.038075430985, 4305.225059489322, 4432.689711720213, 4436.646822719037, 4437.267850804581, 4446.933296000562, 3474.652534746505, 3564.625714300013, 3590.8922732318074, 3592.263585964871, 3749.250149970017, 593.2288025566746, 656.2617055812211, 705.2735682247294, 714.2857142857143, 729.2015243308568, 554.384633057306, 580.5442727459009, 634.2104080419815, 667.8063361625075, 675.2470994840816, 9040.276777857756, 9072.682456114004, 9367.297452691075, 9478.857817132748, 9669.613215471443, 562.9324481062217, 638.1958731997717, 649.4890851128174, 662.3145044878623, 669.4811521071111, 4366.934495982563, 4436.157130145262, 4536.79584418702, 4549.863504094882, 4646.831818747666, 84409.7795110242, 155783.44216557688, 157592.63611045844, 158429.20785396, 158953.0, 111115.0, 135384.6461535392, 136777.0, 136802.0, 138585.0, 98161.509192455, 118209.40895295469, 121913.0, 122552.0, 123231.0, 8820.25027872638, 8843.336749743667, 8851.557422128997, 8907.955460222658, 8954.0, 52879.0, 61238.4690382744, 63767.724645507755, 67089.66455167693, 67814.66092669505, 79608.0, 81821.0, 86100.56949715212, 86569.0, 86935.56532217299, 13221.471141154247, 13281.335933203494, 13297.468101275841, 13582.728345433234, 13602.319884005958, 14417.207053612152, 14447.49433769813, 14672.413103475741, 14838.925805370904, 14960.551183464513, 13697.383617737027, 13825.79261311061, 13863.0, 14100.435982560582, 14444.988850780344, 13496.122752021087, 13849.238291894042, 14070.507532236323, 14121.717565648834, 14375.0, 13565.050446468653, 13845.861541384456, 13964.022518423613, 14180.432782688576, 14282.928780341725, 10983.780324393627, 11049.944750276518, 11248.344288106562, 11511.19421640477, 11667.883321167019, 9050.456972581665, 9713.514324283899, 10976.562694419132, 11358.148138889452, 11664.416779161178], "value": 7802.491849086815, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1658.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 110.0, 95.0, 173.0, 172.0, 110.0, 124.0, 172.0, 116.0, 118.0], "value": 131.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 113.0, 134.0, 162.0, 111.0, 131.0, 132.0, 113.0, 162.0, 114.0], "value": 131.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 217.0, 226.0, 263.0, 283.0, 209.0, 200.0, 206.0, 197.0, 194.0], "value": 219.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 86.0, 79.0, 140.0, 63.0, 71.0, 60.0, 66.0, 134.0, 58.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 75.0, 116.0, 73.0, 74.0, 95.0, 104.0, 92.0, 99.0, 148.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 89.0, 131.0, 128.0, 92.0, 88.0, 128.0, 97.0, 78.0, 130.0], "value": 106.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 129.0, 166.0, 169.0, 101.0, 148.0, 102.0, 106.0, 135.0, 171.0], "value": 132.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 95.0, 90.0, 92.0, 94.0, 104.0, 151.0, 152.0, 91.0, 93.0], "value": 105.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 52.0, 81.0, 55.0, 63.0, 64.0, 52.0, 56.0, 61.0, 89.0], "value": 61.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 76.0, 71.0, 93.0, 97.0, 100.0, 74.0, 69.0, 73.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 85.0, 103.0, 80.0, 92.0, 101.0, 100.0, 82.0, 108.0, 112.0], "value": 95.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 140.0, 139.0, 140.0, 142.0, 145.0, 149.0, 162.0, 194.0, 150.0], "value": 150.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 177.0, 173.0, 172.0, 177.0, 173.0, 170.0, 249.0, 234.0, 181.0], "value": 187.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 75.0, 79.0, 91.0, 87.0, 91.0, 92.0, 79.0, 69.0], "value": 79.8, "unit": "score"}]}]} 20:05:12 INFO - Return code: 0 20:05:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:05:12 ERROR - # TBPL SUCCESS # 20:05:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:05:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:05:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:05:12 INFO - 2016-08-30 20:05:12.515 screenresolution[1940:15817] starting screenresolution argv=screenresolution get 20:05:12 INFO - 2016-08-30 20:05:12.518 screenresolution[1940:15817] Display 0: 1600x1200x32@60 20:05:12 INFO - 2016-08-30 20:05:12.524 screenresolution[1941:15820] starting screenresolution argv=screenresolution list 20:05:12 INFO - Available Modes on Display 0 20:05:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:05:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:05:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:05:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:05:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:05:12 INFO - Intel Iris: 20:05:12 INFO - Chipset Model: Intel Iris 20:05:12 INFO - Type: GPU 20:05:12 INFO - Bus: Built-In 20:05:12 INFO - VRAM (Dynamic, Max): 1536 MB 20:05:12 INFO - Vendor: Intel (0x8086) 20:05:12 INFO - Device ID: 0x0a2e 20:05:12 INFO - Revision ID: 0x0009 20:05:12 INFO - Displays: 20:05:12 INFO - Display: 20:05:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:05:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:05:12 INFO - Display Serial Number: 1600x1200 60 20:05:12 INFO - Main Display: Yes 20:05:12 INFO - Mirror: Off 20:05:12 INFO - Online: Yes 20:05:12 INFO - Rotation: Supported 20:05:12 INFO - Return code: 0 20:05:12 INFO - Running post-action listener: _resource_record_post_action 20:05:12 INFO - [mozharness: 2016-08-31 03:05:12.771284Z] Finished run-tests step (success) 20:05:12 INFO - Running post-run listener: _resource_record_post_run 20:05:12 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 1179648; Write bytes: 707587072; Read time: 16; Write time: 2101 20:05:12 INFO - TinderboxPrint: CPU usage
54.5% 20:05:12 INFO - TinderboxPrint: I/O read bytes / time
1,179,648 / 16 20:05:12 INFO - TinderboxPrint: I/O write bytes / time
707,587,072 / 2,101 20:05:12 INFO - TinderboxPrint: CPU idle
2,204.5 (45.5%) 20:05:12 INFO - TinderboxPrint: CPU system
978.8 (20.2%) 20:05:12 INFO - TinderboxPrint: CPU user
1,662.5 (34.3%) 20:05:12 INFO - TinderboxPrint: Swap in / out
407,441,408 / 0 20:05:12 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 390148608; Write bytes: 385435648; Read time: 29380; Write time: 732 20:05:12 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 1167360; Write bytes: 298017792; Read time: 16; Write time: 1320 20:05:13 INFO - Running post-run listener: _upload_blobber_files 20:05:13 INFO - Blob upload gear active. 20:05:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:05:13 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 20:05:13 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'] 20:05:13 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 20:05:13 INFO - (blobuploader) - INFO - Open directory for files ... 20:05:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:05:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:05:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:05:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:05:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:05:14 INFO - (blobuploader) - INFO - Done attempting. 20:05:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:05:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:05:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:05:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:05:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:05:15 INFO - (blobuploader) - INFO - Done attempting. 20:05:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:05:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:05:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:05:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:05:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:05:19 INFO - (blobuploader) - INFO - Done attempting. 20:05:19 INFO - (blobuploader) - INFO - Iteration through files over. 20:05:19 INFO - Return code: 0 20:05:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:05:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:05:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06c029ef88a8b1d7cd4fdf4faa4f25918dacb8d8c8afaa33c4d84cb7e098466f92817e18fa8598c0af42b7d1744435300322bac6018df7df76681df2401e688f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a48fa5c3f3431d03224fa16ec19eef563c9c8e9907cef68d815dff0a58da3f4262c8bfe20938d1a42726964fc2b8b6b4d4886ffd7e6b1593cf29e914e9281eb7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa114693aa2dfbb684c2ba54c0d5077083bbe2322f2d392ebd3ff2d6224bf9e374d388bed22f847ef84c9a80cd98deaa38ed4fa8b05934a95b53f509fce7b9f8"} 20:05:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:05:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:05:19 INFO - Contents: 20:05:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06c029ef88a8b1d7cd4fdf4faa4f25918dacb8d8c8afaa33c4d84cb7e098466f92817e18fa8598c0af42b7d1744435300322bac6018df7df76681df2401e688f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a48fa5c3f3431d03224fa16ec19eef563c9c8e9907cef68d815dff0a58da3f4262c8bfe20938d1a42726964fc2b8b6b4d4886ffd7e6b1593cf29e914e9281eb7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa114693aa2dfbb684c2ba54c0d5077083bbe2322f2d392ebd3ff2d6224bf9e374d388bed22f847ef84c9a80cd98deaa38ed4fa8b05934a95b53f509fce7b9f8"} 20:05:19 INFO - Running post-run listener: copy_logs_to_upload_dir 20:05:19 INFO - Copying logs to upload dir... 20:05:19 INFO - mkdir: /builds/slave/test/build/upload/logs 20:05:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.602418 ========= master_lag: 4.41 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-08-30 20:05:23.666217) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 6 secs) (at 2016-08-30 20:05:23.669540) ========= 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.eK6Hra58x7/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.A8PRgwHgsw/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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/06c029ef88a8b1d7cd4fdf4faa4f25918dacb8d8c8afaa33c4d84cb7e098466f92817e18fa8598c0af42b7d1744435300322bac6018df7df76681df2401e688f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a48fa5c3f3431d03224fa16ec19eef563c9c8e9907cef68d815dff0a58da3f4262c8bfe20938d1a42726964fc2b8b6b4d4886ffd7e6b1593cf29e914e9281eb7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa114693aa2dfbb684c2ba54c0d5077083bbe2322f2d392ebd3ff2d6224bf9e374d388bed22f847ef84c9a80cd98deaa38ed4fa8b05934a95b53f509fce7b9f8"} build_url:https://queue.taskcluster.net/v1/task/AbVxyZ4fR_ODYZtftAdmZA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010944 build_url: 'https://queue.taskcluster.net/v1/task/AbVxyZ4fR_ODYZtftAdmZA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06c029ef88a8b1d7cd4fdf4faa4f25918dacb8d8c8afaa33c4d84cb7e098466f92817e18fa8598c0af42b7d1744435300322bac6018df7df76681df2401e688f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a48fa5c3f3431d03224fa16ec19eef563c9c8e9907cef68d815dff0a58da3f4262c8bfe20938d1a42726964fc2b8b6b4d4886ffd7e6b1593cf29e914e9281eb7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa114693aa2dfbb684c2ba54c0d5077083bbe2322f2d392ebd3ff2d6224bf9e374d388bed22f847ef84c9a80cd98deaa38ed4fa8b05934a95b53f509fce7b9f8"}' ========= master_lag: 6.20 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 6 secs) (at 2016-08-30 20:05:29.882591) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-08-30 20:05:29.882968) ========= 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.eK6Hra58x7/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.A8PRgwHgsw/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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.005549 ========= master_lag: 5.26 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-08-30 20:05:35.143814) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2016-08-30 20:05:35.144118) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2016-08-30 20:05:36.437990) ========= ========= Total master_lag: 16.22 =========