builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0206 starttime: 1481204684.37 results: success (0) buildid: 20161208030206 builduid: 423524bcf0d147199a87b3bece1de370 revision: c2526f6786f074888d71c8e166a02aea3e19e75b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-08 05:44:44.365903) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-08 05:44:44.366475) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-08 05:44:44.366761) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-08 05:44:44.443584) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 05:44:44.443954) ========= 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.Omo6nIVkg3/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.RYR72JuhNC/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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-12-08 05:44:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2016-12-08 05:44:45 (161 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.624965 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 05:44:45.190900) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 05:44:45.191217) ========= 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.Omo6nIVkg3/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.RYR72JuhNC/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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.034811 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 05:44:45.327898) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-08 05:44:45.328273) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c2526f6786f074888d71c8e166a02aea3e19e75b --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 c2526f6786f074888d71c8e166a02aea3e19e75b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Omo6nIVkg3/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.RYR72JuhNC/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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-12-08 05:44:45,449 truncating revision to first 12 chars 2016-12-08 05:44:45,449 Setting DEBUG logging. 2016-12-08 05:44:45,449 attempt 1/10 2016-12-08 05:44:45,449 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c2526f6786f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-08 05:44:46,854 unpacking tar archive at: mozilla-central-c2526f6786f0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.683503 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-08 05:44:47.062802) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-08 05:44:47.063284) ========= script_repo_revision: c2526f6786f074888d71c8e166a02aea3e19e75b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-08 05:44:47.066939) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-08 05:44:47.067951) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-08 05:44:47.105917) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-12-08 05:44:47.106289) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--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.Omo6nIVkg3/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.RYR72JuhNC/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:44:47 INFO - MultiFileLogger online at 20161208 05:44:47 in /builds/slave/test 05:44:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:44:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:44:47 INFO - {'append_to_log': False, 05:44:47 INFO - 'base_work_dir': '/builds/slave/test', 05:44:47 INFO - 'blob_upload_branch': 'Firefox', 05:44:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:44:47 INFO - 'branch': 'Firefox', 05:44:47 INFO - 'buildbot_json_path': 'buildprops.json', 05:44:47 INFO - 'config_files': ('talos/mac_config.py',), 05:44:47 INFO - 'default_actions': ('clobber', 05:44:47 INFO - 'read-buildbot-config', 05:44:47 INFO - 'download-and-extract', 05:44:47 INFO - 'populate-webroot', 05:44:47 INFO - 'create-virtualenv', 05:44:47 INFO - 'install', 05:44:47 INFO - 'run-tests'), 05:44:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:44:47 INFO - 'download_minidump_stackwalk': True, 05:44:47 INFO - 'download_symbols': 'ondemand', 05:44:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:44:47 INFO - 'tooltool.py': '/tools/tooltool.py', 05:44:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:44:47 INFO - '/tools/misc-python/virtualenv.py')}, 05:44:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:44:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:44:47 INFO - 'installer_path': 'installer.exe', 05:44:47 INFO - 'log_level': 'info', 05:44:47 INFO - 'log_name': 'talos', 05:44:47 INFO - 'log_to_console': True, 05:44:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:44:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:44:47 INFO - 'opt_config_files': (), 05:44:47 INFO - 'pip_index': False, 05:44:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:44:47 INFO - 'cmd': ('bash', 05:44:47 INFO - '-c', 05:44:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:44:47 INFO - 'enabled': True, 05:44:47 INFO - 'halt_on_failure': False, 05:44:47 INFO - 'name': 'check_screen_resolution'},), 05:44:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:44:47 INFO - 'cmd': ('bash', 05:44:47 INFO - '-c', 05:44:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:44:47 INFO - 'enabled': True, 05:44:47 INFO - 'halt_on_failure': False, 05:44:47 INFO - 'name': 'check_screen_resolution'},), 05:44:47 INFO - 'run_cmd_checks_enabled': True, 05:44:47 INFO - 'sps_profile': False, 05:44:47 INFO - 'sps_profile_interval': 0, 05:44:47 INFO - 'suite': 'dromaeojs', 05:44:47 INFO - 'system_bits': '32', 05:44:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:44:47 INFO - 'title': 't-yosemite-r7-0206', 05:44:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:44:47 INFO - 'use_talos_json': True, 05:44:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:44:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:44:47 INFO - 'work_dir': 'build'} 05:44:47 INFO - [mozharness: 2016-12-08 13:44:47.312407Z] Running clobber step. 05:44:47 INFO - Running pre-action listener: _resource_record_pre_action 05:44:47 INFO - Running main action method: clobber 05:44:47 INFO - rmtree: /builds/slave/test/build 05:44:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:44:48 INFO - Running post-action listener: _resource_record_post_action 05:44:48 INFO - [mozharness: 2016-12-08 13:44:48.758565Z] Finished clobber step (success) 05:44:48 INFO - [mozharness: 2016-12-08 13:44:48.758692Z] Running read-buildbot-config step. 05:44:48 INFO - Running pre-action listener: _resource_record_pre_action 05:44:48 INFO - Running main action method: read_buildbot_config 05:44:48 INFO - Using buildbot properties: 05:44:48 INFO - { 05:44:48 INFO - "project": "", 05:44:48 INFO - "product": "firefox", 05:44:48 INFO - "script_repo_revision": "production", 05:44:48 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:44:48 INFO - "repository": "", 05:44:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:44:48 INFO - "buildid": "20161208030206", 05:44:48 INFO - "stage_platform": "macosx64", 05:44:48 INFO - "basedir": "/builds/slave/test", 05:44:48 INFO - "nightly_build": "True", 05:44:48 INFO - "buildnumber": 29, 05:44:48 INFO - "slavename": "t-yosemite-r7-0206", 05:44:48 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:44:48 INFO - "platform": "yosemite_r7", 05:44:48 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:44:48 INFO - "branch": "mozilla-central", 05:44:48 INFO - "repo_path": "mozilla-central", 05:44:48 INFO - "revision": "c2526f6786f074888d71c8e166a02aea3e19e75b", 05:44:48 INFO - "pgo_build": "False", 05:44:48 INFO - "builduid": "423524bcf0d147199a87b3bece1de370", 05:44:48 INFO - "slavebuilddir": "test" 05:44:48 INFO - } 05:44:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 05:44:48 INFO - Running post-action listener: _resource_record_post_action 05:44:48 INFO - [mozharness: 2016-12-08 13:44:48.762820Z] Finished read-buildbot-config step (success) 05:44:48 INFO - [mozharness: 2016-12-08 13:44:48.762954Z] Running download-and-extract step. 05:44:48 INFO - Running pre-action listener: _resource_record_pre_action 05:44:48 INFO - Running main action method: download_and_extract 05:44:48 INFO - mkdir: /builds/slave/test/build/tests 05:44:48 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')]} 05:44:48 INFO - trying https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 05:44:48 INFO - Downloading https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 05:44:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 05:44:50 INFO - Downloaded 1199 bytes. 05:44:50 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 05:44:50 INFO - Using the following test package requirements: 05:44:50 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 05:44:50 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:44:50 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 05:44:50 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:44:50 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 05:44:50 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:44:50 INFO - u'jsshell-mac.zip'], 05:44:50 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:44:50 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 05:44:50 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 05:44:50 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:44:50 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 05:44:50 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:44:50 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 05:44:50 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:44:50 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 05:44:50 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:44:50 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 05:44:50 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:44:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 05:44:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:44:50 INFO - Fetch https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 05:44:51 INFO - Expected file size: 16284432 05:44:51 INFO - Obtained file size: 16284432 05:44:57 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:44:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 05:44:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:44:57 INFO - Fetch https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 05:44:58 INFO - Expected file size: 16284432 05:44:58 INFO - Obtained file size: 16284432 05:45:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 05:45:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:45:05 INFO - Fetch https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 05:45:05 INFO - Expected file size: 14409734 05:45:05 INFO - Obtained file size: 14409734 05:45:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:06 INFO - trying https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:45:06 INFO - Downloading https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 05:45:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 05:45:09 INFO - Downloaded 107739399 bytes. 05:45:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:45:09 INFO - mkdir: /builds/slave/test/properties 05:45:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:45:09 INFO - Writing to file /builds/slave/test/properties/build_url 05:45:09 INFO - Contents: 05:45:09 INFO - build_url:https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:45:10 INFO - Running post-action listener: _resource_record_post_action 05:45:10 INFO - Running post-action listener: set_extra_try_arguments 05:45:10 INFO - [mozharness: 2016-12-08 13:45:10.409417Z] Finished download-and-extract step (success) 05:45:10 INFO - [mozharness: 2016-12-08 13:45:10.409572Z] Running populate-webroot step. 05:45:10 INFO - Running pre-action listener: _resource_record_pre_action 05:45:10 INFO - Running main action method: populate_webroot 05:45:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:45:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:45:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:45:10 INFO - '--tppagecycles', 05:45:10 INFO - '7'], 05:45:10 INFO - 'tests': ['tsvgm']}}, 05:45:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:45:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:45:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:45:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:45:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:45:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:45:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:45:10 INFO - 'talos_options': ['--disable-e10s'], 05:45:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:45:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:45:10 INFO - 'talos_options': ['--disable-e10s'], 05:45:10 INFO - 'tests': ['damp', 'tps']}, 05:45:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:45:10 INFO - 'tests': ['damp', 'tps']}, 05:45:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:45:10 INFO - 'tests': ['dromaeo_dom']}, 05:45:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:45:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:45:10 INFO - 'tests': ['basic_compositor_video']}, 05:45:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:45:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:45:10 INFO - 'tests': ['a11yr', 05:45:10 INFO - 'ts_paint', 05:45:10 INFO - 'tpaint', 05:45:10 INFO - 'sessionrestore', 05:45:10 INFO - 'sessionrestore_no_auto_restore', 05:45:10 INFO - 'tabpaint']}, 05:45:10 INFO - 'other-e10s': {'tests': ['a11yr', 05:45:10 INFO - 'ts_paint', 05:45:10 INFO - 'tpaint', 05:45:10 INFO - 'sessionrestore', 05:45:10 INFO - 'sessionrestore_no_auto_restore', 05:45:10 INFO - 'tabpaint']}, 05:45:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:45:10 INFO - 'ts_paint', 05:45:10 INFO - 'tpaint', 05:45:10 INFO - 'sessionrestore', 05:45:10 INFO - 'sessionrestore_no_auto_restore', 05:45:10 INFO - 'tabpaint']}, 05:45:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:45:10 INFO - 'ts_paint', 05:45:10 INFO - 'tpaint', 05:45:10 INFO - 'sessionrestore', 05:45:10 INFO - 'sessionrestore_no_auto_restore', 05:45:10 INFO - 'tabpaint']}, 05:45:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:45:10 INFO - 'tests': ['a11yr', 05:45:10 INFO - 'ts_paint', 05:45:10 INFO - 'tpaint', 05:45:10 INFO - 'sessionrestore', 05:45:10 INFO - 'sessionrestore_no_auto_restore', 05:45:10 INFO - 'tabpaint']}, 05:45:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:45:10 INFO - 'tests': ['a11yr', 05:45:10 INFO - 'ts_paint', 05:45:10 INFO - 'tpaint', 05:45:10 INFO - 'sessionrestore', 05:45:10 INFO - 'sessionrestore_no_auto_restore', 05:45:10 INFO - 'tabpaint']}, 05:45:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:45:10 INFO - 'tests': ['tsvgx', 05:45:10 INFO - 'tsvgr_opacity', 05:45:10 INFO - 'tart', 05:45:10 INFO - 'tscrollx', 05:45:10 INFO - 'cart', 05:45:10 INFO - 'tsvg_static']}, 05:45:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:45:10 INFO - 'tsvgr_opacity', 05:45:10 INFO - 'tart', 05:45:10 INFO - 'tscrollx', 05:45:10 INFO - 'cart', 05:45:10 INFO - 'tsvg_static']}, 05:45:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:45:10 INFO - 'talos_options': ['--disable-e10s'], 05:45:10 INFO - 'tests': ['tp5o']}, 05:45:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:45:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:45:10 INFO - 'talos_options': ['--disable-e10s', 05:45:10 INFO - '--xperf_path', 05:45:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:10 INFO - 'tests': ['tp5n']}, 05:45:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:45:10 INFO - 'talos_options': ['--xperf_path', 05:45:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:10 INFO - 'tests': ['tp5n']}}, 05:45:10 INFO - 'talos.zip': {'path': '', 05:45:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:45:10 INFO - Running post-action listener: _resource_record_post_action 05:45:10 INFO - [mozharness: 2016-12-08 13:45:10.428384Z] Finished populate-webroot step (success) 05:45:10 INFO - [mozharness: 2016-12-08 13:45:10.428521Z] Running create-virtualenv step. 05:45:10 INFO - Running pre-action listener: _resource_record_pre_action 05:45:10 INFO - Running main action method: create_virtualenv 05:45:10 INFO - Creating virtualenv /builds/slave/test/build/venv 05:45:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:45:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:45:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:45:10 INFO - Using real prefix '/tools/python27' 05:45:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:45:11 INFO - Installing distribute.............................................................................................................................................................................................done. 05:45:14 INFO - Installing pip.................done. 05:45:14 INFO - Return code: 0 05:45:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:45:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:45:14 INFO - Reading from file tmpfile_stdout 05:45:14 INFO - Output received: 05:45:14 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:45:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1012fc3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101272570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97ab575920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101111d30>, '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 0x100f78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101109b20>, '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.Omo6nIVkg3/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.RYR72JuhNC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:45:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:45:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:45:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Omo6nIVkg3/Render', 05:45:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:14 INFO - 'HOME': '/Users/cltbld', 05:45:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:14 INFO - 'LOGNAME': 'cltbld', 05:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:14 INFO - 'MOZ_NO_REMOTE': '1', 05:45:14 INFO - 'NO_EM_RESTART': '1', 05:45:14 INFO - 'PAGER': '/bin/cat', 05:45:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:14 INFO - 'PWD': '/builds/slave/test', 05:45:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:14 INFO - 'SHELL': '/bin/bash', 05:45:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RYR72JuhNC/Listeners', 05:45:14 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 05:45:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:14 INFO - 'USER': 'cltbld', 05:45:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:14 INFO - 'XPC_FLAGS': '0x0', 05:45:14 INFO - 'XPC_SERVICE_NAME': '0', 05:45:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:45:14 INFO - Cleaning up... 05:45:14 INFO - Return code: 0 05:45:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1012fc3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101272570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97ab575920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101111d30>, '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 0x100f78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101109b20>, '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.Omo6nIVkg3/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.RYR72JuhNC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:45:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:45:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:45:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Omo6nIVkg3/Render', 05:45:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:14 INFO - 'HOME': '/Users/cltbld', 05:45:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:14 INFO - 'LOGNAME': 'cltbld', 05:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:14 INFO - 'MOZ_NO_REMOTE': '1', 05:45:14 INFO - 'NO_EM_RESTART': '1', 05:45:14 INFO - 'PAGER': '/bin/cat', 05:45:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:14 INFO - 'PWD': '/builds/slave/test', 05:45:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:14 INFO - 'SHELL': '/bin/bash', 05:45:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RYR72JuhNC/Listeners', 05:45:14 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 05:45:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:14 INFO - 'USER': 'cltbld', 05:45:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:14 INFO - 'XPC_FLAGS': '0x0', 05:45:14 INFO - 'XPC_SERVICE_NAME': '0', 05:45:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:15 INFO - Downloading/unpacking psutil>=3.1.1 05:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:45:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:18 INFO - Installing collected packages: psutil 05:45:18 INFO - Running setup.py install for psutil 05:45:18 INFO - building 'psutil._psutil_osx' extension 05:45:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:45:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:45:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:45:19 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:45:19 INFO - building 'psutil._psutil_posix' extension 05:45:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:45:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:45:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:45:19 INFO - ^ 05:45:19 INFO - 1 warning generated. 05:45:19 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:45:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:19 INFO - Successfully installed psutil 05:45:19 INFO - Cleaning up... 05:45:20 INFO - Return code: 0 05:45:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:20 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 0x1012fc3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101272570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97ab575920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101111d30>, '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 0x100f78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101109b20>, '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.Omo6nIVkg3/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.RYR72JuhNC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:45:20 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 05:45:20 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 05:45:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Omo6nIVkg3/Render', 05:45:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:20 INFO - 'HOME': '/Users/cltbld', 05:45:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:20 INFO - 'LOGNAME': 'cltbld', 05:45:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:20 INFO - 'MOZ_NO_REMOTE': '1', 05:45:20 INFO - 'NO_EM_RESTART': '1', 05:45:20 INFO - 'PAGER': '/bin/cat', 05:45:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:20 INFO - 'PWD': '/builds/slave/test', 05:45:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:20 INFO - 'SHELL': '/bin/bash', 05:45:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RYR72JuhNC/Listeners', 05:45:20 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 05:45:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:20 INFO - 'USER': 'cltbld', 05:45:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:20 INFO - 'XPC_FLAGS': '0x0', 05:45:20 INFO - 'XPC_SERVICE_NAME': '0', 05:45:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:45:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:45:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:45:22 INFO - Installing collected packages: mozsystemmonitor 05:45:22 INFO - Running setup.py install for mozsystemmonitor 05:45:23 INFO - Successfully installed mozsystemmonitor 05:45:23 INFO - Cleaning up... 05:45:23 INFO - Return code: 0 05:45:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:45:23 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')]} 05:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:23 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')]} 05:45:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:23 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 0x1012fc3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101272570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97ab575920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101111d30>, '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 0x100f78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101109b20>, '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.Omo6nIVkg3/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.RYR72JuhNC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:45:23 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 05:45:23 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 05:45:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Omo6nIVkg3/Render', 05:45:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:23 INFO - 'HOME': '/Users/cltbld', 05:45:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:23 INFO - 'LOGNAME': 'cltbld', 05:45:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:23 INFO - 'MOZ_NO_REMOTE': '1', 05:45:23 INFO - 'NO_EM_RESTART': '1', 05:45:23 INFO - 'PAGER': '/bin/cat', 05:45:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:23 INFO - 'PWD': '/builds/slave/test', 05:45:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:23 INFO - 'SHELL': '/bin/bash', 05:45:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RYR72JuhNC/Listeners', 05:45:23 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 05:45:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:23 INFO - 'USER': 'cltbld', 05:45:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:23 INFO - 'XPC_FLAGS': '0x0', 05:45:23 INFO - 'XPC_SERVICE_NAME': '0', 05:45:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:23 INFO - Downloading/unpacking jsonschema==2.5.1 05:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:45:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:26 INFO - Downloading functools32-3.2.3-2.tar.gz 05:45:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:45:26 INFO - warning: no files found matching '*.txt' 05:45:26 INFO - no previously-included directories found matching 'build' 05:45:26 INFO - no previously-included directories found matching 'dist' 05:45:26 INFO - no previously-included directories found matching '.git*' 05:45:26 INFO - Installing collected packages: jsonschema, functools32 05:45:26 INFO - Running setup.py install for functools32 05:45:26 INFO - warning: no files found matching '*.txt' 05:45:26 INFO - no previously-included directories found matching 'build' 05:45:26 INFO - no previously-included directories found matching 'dist' 05:45:26 INFO - no previously-included directories found matching '.git*' 05:45:26 INFO - Successfully installed jsonschema functools32 05:45:26 INFO - Cleaning up... 05:45:26 INFO - Return code: 0 05:45:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:45: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')]} 05:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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')]} 05:45:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:26 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 0x1012fc3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101272570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97ab575920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101111d30>, '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 0x100f78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101109b20>, '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.Omo6nIVkg3/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.RYR72JuhNC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:45:26 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 05:45:26 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 05:45:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Omo6nIVkg3/Render', 05:45:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:26 INFO - 'HOME': '/Users/cltbld', 05:45:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:26 INFO - 'LOGNAME': 'cltbld', 05:45:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:26 INFO - 'MOZ_NO_REMOTE': '1', 05:45:26 INFO - 'NO_EM_RESTART': '1', 05:45:26 INFO - 'PAGER': '/bin/cat', 05:45:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:26 INFO - 'PWD': '/builds/slave/test', 05:45:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:26 INFO - 'SHELL': '/bin/bash', 05:45:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RYR72JuhNC/Listeners', 05:45:26 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 05:45:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:26 INFO - 'USER': 'cltbld', 05:45:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:26 INFO - 'XPC_FLAGS': '0x0', 05:45:26 INFO - 'XPC_SERVICE_NAME': '0', 05:45:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:45:27 INFO - Cleaning up... 05:45:27 INFO - Return code: 0 05:45:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:45:27 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')]} 05:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:27 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')]} 05:45:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:27 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 0x1012fc3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101272570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97ab575920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101111d30>, '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 0x100f78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101109b20>, '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.Omo6nIVkg3/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.RYR72JuhNC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:45:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:45:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:45:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Omo6nIVkg3/Render', 05:45:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:27 INFO - 'HOME': '/Users/cltbld', 05:45:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:27 INFO - 'LOGNAME': 'cltbld', 05:45:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:27 INFO - 'MOZ_NO_REMOTE': '1', 05:45:27 INFO - 'NO_EM_RESTART': '1', 05:45:27 INFO - 'PAGER': '/bin/cat', 05:45:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:27 INFO - 'PWD': '/builds/slave/test', 05:45:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:27 INFO - 'SHELL': '/bin/bash', 05:45:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RYR72JuhNC/Listeners', 05:45:27 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 05:45:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:27 INFO - 'USER': 'cltbld', 05:45:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:27 INFO - 'XPC_FLAGS': '0x0', 05:45:27 INFO - 'XPC_SERVICE_NAME': '0', 05:45:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:27 INFO - Downloading/unpacking blobuploader==1.2.4 05:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:29 INFO - Downloading blobuploader-1.2.4.tar.gz 05:45:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:45:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:45:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:30 INFO - Downloading docopt-0.6.1.tar.gz 05:45:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:45:31 INFO - Installing collected packages: blobuploader, requests, docopt 05:45:31 INFO - Running setup.py install for blobuploader 05:45:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:45:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:45:31 INFO - Running setup.py install for requests 05:45:31 INFO - Running setup.py install for docopt 05:45:31 INFO - Successfully installed blobuploader requests docopt 05:45:31 INFO - Cleaning up... 05:45:32 INFO - Return code: 0 05:45:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:32 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 0x1012fc3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101272570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97ab575920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101111d30>, '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 0x100f78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101109b20>, '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.Omo6nIVkg3/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.RYR72JuhNC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:45:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:45:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Omo6nIVkg3/Render', 05:45:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:32 INFO - 'HOME': '/Users/cltbld', 05:45:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:32 INFO - 'LOGNAME': 'cltbld', 05:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:32 INFO - 'MOZ_NO_REMOTE': '1', 05:45:32 INFO - 'NO_EM_RESTART': '1', 05:45:32 INFO - 'PAGER': '/bin/cat', 05:45:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:32 INFO - 'PWD': '/builds/slave/test', 05:45:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:32 INFO - 'SHELL': '/bin/bash', 05:45:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RYR72JuhNC/Listeners', 05:45:32 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 05:45:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:32 INFO - 'USER': 'cltbld', 05:45:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:32 INFO - 'XPC_FLAGS': '0x0', 05:45:32 INFO - 'XPC_SERVICE_NAME': '0', 05:45:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:45:32 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-LVQJTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:45:32 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-_s1Syb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:45:32 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-FaM3Dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:45:32 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-nHsRgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:45:32 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-pLN3sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:45:32 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-z8mBb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:45:32 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-G_eP9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:45:33 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-s7stVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:45:33 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-PcHrD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:45:33 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-A0eyXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:45:33 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-3_Q2VT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:45:33 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-KHo1D1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:45:33 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-G5XxOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:45:33 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-u__E6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:33 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-V76McU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:45:33 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-usK6Qs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:45:33 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-8LtRgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:45:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:45:34 INFO - Running setup.py install for manifestparser 05:45:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:45:34 INFO - Running setup.py install for mozcrash 05:45:34 INFO - Running setup.py install for mozdebug 05:45:34 INFO - Running setup.py install for mozdevice 05:45:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:45:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:45:34 INFO - Running setup.py install for mozfile 05:45:34 INFO - Running setup.py install for mozhttpd 05:45:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:45:34 INFO - Running setup.py install for mozinfo 05:45:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:45:35 INFO - Running setup.py install for mozInstall 05:45:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:45:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:45:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:45:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:45:35 INFO - Running setup.py install for mozleak 05:45:35 INFO - Running setup.py install for mozlog 05:45:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:45:35 INFO - Running setup.py install for moznetwork 05:45:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:45:35 INFO - Running setup.py install for mozprocess 05:45:35 INFO - Running setup.py install for mozprofile 05:45:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:45:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:45:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:45:36 INFO - Running setup.py install for mozrunner 05:45:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:45:36 INFO - Running setup.py install for mozscreenshot 05:45:36 INFO - Running setup.py install for moztest 05:45:36 INFO - Running setup.py install for mozversion 05:45:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:45:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:45:36 INFO - Cleaning up... 05:45:36 INFO - Return code: 0 05:45:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:45:36 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')]} 05:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:36 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')]} 05:45:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:36 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 0x1012fc3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101272570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97ab575920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101111d30>, '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 0x100f78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101109b20>, '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.Omo6nIVkg3/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.RYR72JuhNC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:45:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:45:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:45:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Omo6nIVkg3/Render', 05:45:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:36 INFO - 'HOME': '/Users/cltbld', 05:45:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:36 INFO - 'LOGNAME': 'cltbld', 05:45:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:36 INFO - 'MOZ_NO_REMOTE': '1', 05:45:36 INFO - 'NO_EM_RESTART': '1', 05:45:36 INFO - 'PAGER': '/bin/cat', 05:45:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:36 INFO - 'PWD': '/builds/slave/test', 05:45:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:36 INFO - 'SHELL': '/bin/bash', 05:45:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RYR72JuhNC/Listeners', 05:45:36 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 05:45:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:36 INFO - 'USER': 'cltbld', 05:45:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:36 INFO - 'XPC_FLAGS': '0x0', 05:45:36 INFO - 'XPC_SERVICE_NAME': '0', 05:45:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:45:36 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-dXFccc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:45:37 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-LCrRsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:45:37 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-0Z86wz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:45:37 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-MOSFXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:45:37 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-ppkE1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:45:37 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-COpoSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:45:37 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-VpA0Ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:45:37 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-QGS1Wu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:45:37 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-4DwZ5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:45:37 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-wAS4w6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:45:37 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-VIpenA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:45:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:45:38 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-8QyZIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:45:38 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)) 05:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:45:38 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-pGYIPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:45:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:45:38 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-9gy63Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:45:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:38 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-Hhi3SX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:45:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:45:38 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-lcJ29O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:45:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:45:38 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-pbWq7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:45:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:45:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:45:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:45:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:45:38 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:45:38 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:45:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45: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 05:45:41 INFO - Downloading blessings-1.6.tar.gz 05:45:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:45:41 INFO - Installing collected packages: blessings 05:45:41 INFO - Running setup.py install for blessings 05:45:41 INFO - Successfully installed blessings 05:45:41 INFO - Cleaning up... 05:45:41 INFO - Return code: 0 05:45:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:45:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:45:41 INFO - Reading from file tmpfile_stdout 05:45:41 INFO - Current package versions: 05:45:41 INFO - blessings == 1.6 05:45:41 INFO - blobuploader == 1.2.4 05:45:41 INFO - docopt == 0.6.1 05:45:41 INFO - functools32 == 3.2.3-2 05:45:41 INFO - jsonschema == 2.5.1 05:45:41 INFO - manifestparser == 1.1 05:45:41 INFO - mozInstall == 1.12 05:45:41 INFO - mozcrash == 1.0 05:45:41 INFO - mozdebug == 0.1 05:45:41 INFO - mozdevice == 0.49 05:45:41 INFO - mozfile == 1.2 05:45:41 INFO - mozhttpd == 0.7 05:45:41 INFO - mozinfo == 0.9 05:45:41 INFO - mozleak == 0.1 05:45:41 INFO - mozlog == 3.4 05:45:41 INFO - moznetwork == 0.27 05:45:41 INFO - mozprocess == 0.23 05:45:41 INFO - mozprofile == 0.28 05:45:41 INFO - mozrunner == 6.13 05:45:41 INFO - mozscreenshot == 0.1 05:45:41 INFO - mozsystemmonitor == 0.3 05:45:41 INFO - moztest == 0.7 05:45:41 INFO - mozversion == 1.4 05:45:41 INFO - psutil == 3.1.1 05:45:41 INFO - requests == 1.2.3 05:45:41 INFO - wsgiref == 0.1.2 05:45:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:45: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')]} 05:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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')]} 05:45:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:41 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 0x1012fc3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101272570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97ab575920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101111d30>, '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 0x100f78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101109b20>, '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.Omo6nIVkg3/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.RYR72JuhNC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:45:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:45:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Omo6nIVkg3/Render', 05:45:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:41 INFO - 'HOME': '/Users/cltbld', 05:45:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:41 INFO - 'LOGNAME': 'cltbld', 05:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:41 INFO - 'MOZ_NO_REMOTE': '1', 05:45:41 INFO - 'NO_EM_RESTART': '1', 05:45:41 INFO - 'PAGER': '/bin/cat', 05:45:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:41 INFO - 'PWD': '/builds/slave/test', 05:45:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:41 INFO - 'SHELL': '/bin/bash', 05:45:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RYR72JuhNC/Listeners', 05:45:41 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 05:45:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:41 INFO - 'USER': 'cltbld', 05:45:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:41 INFO - 'XPC_FLAGS': '0x0', 05:45:41 INFO - 'XPC_SERVICE_NAME': '0', 05:45:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:45:42 INFO - Cleaning up... 05:45:42 INFO - Return code: 0 05:45:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:42 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 0x1012fc3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101272570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97ab575920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101111d30>, '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 0x100f78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101109b20>, '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.Omo6nIVkg3/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.RYR72JuhNC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:45:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:45:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:45:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Omo6nIVkg3/Render', 05:45:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:45:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:45:42 INFO - 'HOME': '/Users/cltbld', 05:45:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:45:42 INFO - 'LOGNAME': 'cltbld', 05:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:42 INFO - 'MOZ_NO_REMOTE': '1', 05:45:42 INFO - 'NO_EM_RESTART': '1', 05:45:42 INFO - 'PAGER': '/bin/cat', 05:45:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:42 INFO - 'PWD': '/builds/slave/test', 05:45:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:45:42 INFO - 'SHELL': '/bin/bash', 05:45:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RYR72JuhNC/Listeners', 05:45:42 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 05:45:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:45:42 INFO - 'USER': 'cltbld', 05:45:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:45:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:42 INFO - 'XPC_FLAGS': '0x0', 05:45:42 INFO - 'XPC_SERVICE_NAME': '0', 05:45:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:45:42 INFO - Cleaning up... 05:45:42 INFO - Return code: 0 05:45:42 INFO - Running post-action listener: _resource_record_post_action 05:45:42 INFO - Running post-action listener: _start_resource_monitoring 05:45:42 INFO - Starting resource monitoring. 05:45:42 INFO - [mozharness: 2016-12-08 13:45:42.506699Z] Finished create-virtualenv step (success) 05:45:42 INFO - [mozharness: 2016-12-08 13:45:42.507667Z] Running install step. 05:45:42 INFO - Running pre-action listener: _resource_record_pre_action 05:45:42 INFO - Running main action method: install 05:45:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:45:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:45:42 INFO - Reading from file tmpfile_stdout 05:45:42 INFO - Detecting whether we're running mozinstall >=1.0... 05:45:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:45:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:45:42 INFO - Reading from file tmpfile_stdout 05:45:42 INFO - Output received: 05:45:42 INFO - Usage: mozinstall [options] installer 05:45:42 INFO - Options: 05:45:42 INFO - -h, --help show this help message and exit 05:45:42 INFO - -d DEST, --destination=DEST 05:45:42 INFO - Directory to install application into. [default: 05:45:42 INFO - "/builds/slave/test"] 05:45:42 INFO - --app=APP Application being installed. [default: firefox] 05:45:42 INFO - mkdir: /builds/slave/test/build/application 05:45:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:45:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:46:15 INFO - Reading from file tmpfile_stdout 05:46:15 INFO - Output received: 05:46:15 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:46:15 INFO - Running post-action listener: _resource_record_post_action 05:46:15 INFO - [mozharness: 2016-12-08 13:46:15.678641Z] Finished install step (success) 05:46:15 INFO - [mozharness: 2016-12-08 13:46:15.678821Z] Running run-tests step. 05:46:15 INFO - Running pre-action listener: _resource_record_pre_action 05:46:15 INFO - Running main action method: run_tests 05:46:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:46:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:46:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:46:15 INFO - 2016-12-08 05:46:15.693 screenresolution[1635:8313] starting screenresolution argv=screenresolution get 05:46:15 INFO - 2016-12-08 05:46:15.695 screenresolution[1635:8313] Display 0: 1600x1200x32@60 05:46:15 INFO - 2016-12-08 05:46:15.701 screenresolution[1636:8315] starting screenresolution argv=screenresolution list 05:46:15 INFO - Available Modes on Display 0 05:46:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:46:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:46:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:46:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:46:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:46:15 INFO - Intel Iris: 05:46:15 INFO - Chipset Model: Intel Iris 05:46:15 INFO - Type: GPU 05:46:15 INFO - Bus: Built-In 05:46:15 INFO - VRAM (Dynamic, Max): 1536 MB 05:46:15 INFO - Vendor: Intel (0x8086) 05:46:15 INFO - Device ID: 0x0a2e 05:46:15 INFO - Revision ID: 0x0009 05:46:15 INFO - Displays: 05:46:15 INFO - Display: 05:46:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:46:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:46:15 INFO - Display Serial Number: 1600x1200 60 05:46:15 INFO - Main Display: Yes 05:46:15 INFO - Mirror: Off 05:46:15 INFO - Online: Yes 05:46:15 INFO - Rotation: Supported 05:46:15 INFO - Return code: 0 05:46:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:46:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:46:15 INFO - Python 2.7.3 05:46:15 INFO - Return code: 0 05:46:15 INFO - grabbing minidump binary from tooltool 05:46:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:15 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 0x101111d30>, '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 0x100f78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101109b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:46:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:46:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:46:15 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 05:46:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:46:16 INFO - Return code: 0 05:46:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:46:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:46:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:46:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:46:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:46:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0206', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:46:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0206 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:46:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Omo6nIVkg3/Render', 05:46:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:16 INFO - 'HOME': '/Users/cltbld', 05:46:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:16 INFO - 'LOGNAME': 'cltbld', 05:46:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:46:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:46:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:16 INFO - 'MOZ_NO_REMOTE': '1', 05:46:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:46:16 INFO - 'NO_EM_RESTART': '1', 05:46:16 INFO - 'PAGER': '/bin/cat', 05:46:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:16 INFO - 'PWD': '/builds/slave/test', 05:46:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:46:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:16 INFO - 'SHELL': '/bin/bash', 05:46:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RYR72JuhNC/Listeners', 05:46:16 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 05:46:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:16 INFO - 'USER': 'cltbld', 05:46:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:16 INFO - 'XPC_FLAGS': '0x0', 05:46:16 INFO - 'XPC_SERVICE_NAME': '0', 05:46:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0206', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:46:16 INFO - mozversion application_buildid: 20161208030206 05:46:16 INFO - mozversion application_changeset: c2526f6786f074888d71c8e166a02aea3e19e75b 05:46:16 INFO - mozversion application_display_name: Nightly 05:46:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:46:16 INFO - mozversion application_name: Firefox 05:46:16 INFO - mozversion application_remotingname: firefox 05:46:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:46:16 INFO - mozversion application_vendor: Mozilla 05:46:16 INFO - mozversion application_version: 53.0a1 05:46:16 INFO - mozversion platform_buildid: 20161208030206 05:46:16 INFO - mozversion platform_changeset: c2526f6786f074888d71c8e166a02aea3e19e75b 05:46:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:46:16 INFO - mozversion platform_version: 53.0a1 05:46:16 INFO - using testdate: 1481204776 05:46:16 INFO - actual date: 1481204776 05:46:16 INFO - starting webserver on 'localhost:49247' 05:46:16 INFO - SUITE-START | Running 2 tests 05:46:16 INFO - TEST-START | dromaeo_css 05:46:16 INFO - operating with platform_type : mac_ 05:46:16 INFO - Initialising browser for dromaeo_css test... 05:46:16 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/tmp12QOCN/profile http://localhost:49247/getInfo.html) 05:46:19 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 05:46:19 INFO - PROCESS | 1646 | colorDepth:24 05:46:19 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 05:46:19 INFO - PROCESS | 1646 | __metrics 05:46:19 INFO - PROCESS | 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:46:19 INFO - PROCESS | 1646 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:46:20 INFO - TEST-INFO | 1646: exit 0 05:46:20 INFO - Browser initialized. 05:46:20 INFO - Running cycle 1/1 for dromaeo_css test... 05:46:20 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/tmp12QOCN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:46:32 INFO - PROCESS | 1650 | RSS: Main: 243204096 05:46:32 INFO - PROCESS | 1650 | 05:47:23 INFO - PROCESS | 1650 | 1481204843610 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:49:36 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49247/tests/dromaeo/cssquery-ext.html) 05:49:38 INFO - PROCESS | 1650 | RSS: Main: 405561344 05:49:38 INFO - PROCESS | 1650 | 05:52:41 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-ext.html (next: http://localhost:49247/tests/dromaeo/cssquery-jquery.html) 05:52:41 INFO - PROCESS | 1650 | RSS: Main: 372125696 05:52:41 INFO - PROCESS | 1650 | 05:55:44 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49247/tests/dromaeo/cssquery-mootools.html) 05:55:44 INFO - PROCESS | 1650 | RSS: Main: 367165440 05:55:44 INFO - PROCESS | 1650 | 05:58:47 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49247/tests/dromaeo/cssquery-prototype.html) 05:58:47 INFO - PROCESS | 1650 | RSS: Main: 346394624 05:58:47 INFO - PROCESS | 1650 | 06:01:51 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49247/tests/dromaeo/cssquery-yui.html) 06:01:51 INFO - PROCESS | 1650 | RSS: Main: 330440704 06:01:51 INFO - PROCESS | 1650 | 06:04:55 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-yui.html (next: http://localhost:49247/tests/dromaeo/cssquery-dojo.html) 06:04:55 INFO - PROCESS | 1650 | RSS: Main: 381669376 06:04:55 INFO - PROCESS | 1650 | 06:04:55 INFO - PROCESS | 1650 | __start_tp_report 06:04:55 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 06:04:55 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 06:04:55 INFO - PROCESS | 1650 | |i|pagename|runs| 06:04:55 INFO - PROCESS | 1650 | |0;dojo.html;2852.3724780548278;3333.9166520836993;3350.0787283497034;3374.9031564741467;3403.8127902965343;5506.311711036121;5581.581381396396;5588.692621905793;5661.716914154291;5698.03133467311;5596.832095037155;5635.915461268074;5663.292088488939;5679.346875109363;5717.056685646874;4237.639800616951;5116.488351164891;5124.128898087315;5155.76799044042;5196.766145523442;5185.299984502081;5271.472852714736;5274.024305503494;5281;5333.946660533384;5116.641835071547;5192.92210616841;5198.610104242159;5227.372715274153;5271.15661494161;5115.974420127913;5193.766280517386;5199.792008319662;5202.401723801736;5204.089284375219;5095.217183008633;5176.378834539842;5178.559822415099;5190.039842629088;5195.986782577399;5632.014397480424;5635.520980716644;5639.097744360924;5647.37878833328;5676.97814393409;6136.3783883643555;6142.174599684151;6145.832291864576;6146.354632763585;6147.508199344042;6165.537584681167;6192.473639740628;6201.441870231701;6203.162573052626;6207.906881396782;5429.647072940246;5648.181013753024;5726.856828579277;5728.427157284238;5738.282714660668;6231.4391704746795;6261.78083767066;6286.874262514724;6305.306416294204;6308.243010838729;6117.235345581802;6127.84680382994;6148.538859585549;6153.353897840751;6162.7843025494785;6066.575339726265;6106.460667179974;6122.755089796358;6124.908126378108;6213.782517611952;6146.5390095743;6183.474404675653;6190.978488549429;6219.533534984895;6223.782167624111;6236.345183755731;6250.781222657276;6255.186825712628;6256.655883926428;6277.8744425111245;4811.975940120277;4844;4941.332920055746;4945.184044632667;4966.9817687374725;4315.438992930899;4358.670605465363;4370.344448332776;4415.470143582791;4449.354843547668;5668.894565559759;5696.031674615326;5701.458361455655;5711.771529138788;5807.535397168216;6258.624482531062;6288.717007734663;6307.274663413675;6308.842278943063;6325.9051114233325;4519.389882365838;5349;5756.136579513023;5763.366029736726;5764.279465066867;5287.259783630295;5289.656172348785;5334.359876814807;5348.090824559834;5365.517103460707;6280.560360774702;6288.308286088618;6302.716377763103;6306.590071645328;6313.96843015782;6221.129041934042;6275.090111933835;6286.4342209201395;6301.779437719658;6358;6224.62652240867;6276.717547710456;6294.5279104068295;6300.306966233619;6306.779262725966;6089.48239399656;6108.159949115189;6134.754609815557;6185.381461853779;6192.566520343533;6257.186565746424;6261.3112557617715;6268.216472940882;6278.7488500461295;6279.215098112736;5184.611154163377;5868.67722275279;6023.247094113236;6077;6093.817185484442;5923.674197919156;5948.910766338422;5976.163337132718;5995.730192141277;6002.399760023963;5891.617044892068;5895.115732639967;5923.585349025527;5928.051511758098;5941.702914854153;5984.281886173687;6010.098485227251;6042.425969532887;6047.274327080779;6061.272647282178;5739.196512488338;5802.332731735735;5875.970620146872;5877.4122587742595;5887.028640274307 06:04:55 INFO - PROCESS | 1650 | |1;ext.html;479.1806011719959;484.7624663914683;488.0945845456679;511.60350728185665;547.4060644201041;24786.752132478694;31224.687753122464;39283.0179245519;39375.40936885949;41321.69426445885;39588.60411395885;39855.202895942064;39933.600663993355;39994.80002599983;40004;8449.57752112395;9237.76905577361;9418;9422.858657120149;9448.196903263231;8340.249377556018;8551.358648101386;8552.657893684276;8559.22966932976;10887.401192934385;10958.616448424307;11223.60717374892;11226.831597526043;11233.438328083605;11264.605738799144;11123.666290011313;11191.608293709682;11194.216404851664;11197.048250898684;11198.608048718337;9440.669576564856;11042;11101.278416902875;11119.833202501968;11124.721881952935;38614.22771544554;39008.854513001774;39035;39060.60939390626;39066.02334941621;3328.051505320996;3358.932821343559;3368.34317308125;3498.94751578724;3874.128321127752;29300.706992930012;29676.258093547618;29918;30322.241943951576;30333.393332133455;3150.984245078783;3154.3375891062906;3181.793183443092;3206.5190221466733;3267.6895694908944;458659;480198;480371.9999999965;481932;483197;56379.71810140923;56879.43120568741;57007.71496142493;57019.57451063757;57054.429455704914;55217.723911380184;55246.723766381714;55410.89178216413;59239;59352.40647593555;15077.623059423602;15280.853935954849;15291.929564930571;15298.847011529742;15320.004199726982;11676.94161529187;11734.11994100446;11771.176017678852;11798.233114847679;11804.350760708072;13546.93226533861;14002.929985350009;14370.712585748226;15344.923275383551;15860.365585376687;5392.544013116437;5903.586748927534;6049.848753781191;6092.573519853568;6187;852.6504133305315;911.7128104647015;973.5424350555228;1001.6293971230546;1019.454591793387;27209;28463.28841778972;28653.85673071663;28725.56911646327;28995.420091598473;1027.5152404775179;1042.4996001919121;1052.826283663187;1069.9518521666544;1089.319175515303;14765.33555989983;14771.187584682946;14867.405303787727;15113.395464181529;15169.469068582768;182779.08610456862;182875;183045;184355;184746;47398.763006185436;48540.75729621329;48647;55034.72482637641;55550.16674749882;1297.4096785962365;1314.8159257703928;1345.9327033648278;1351.9932400337934;1357.5248662967883;21382;29756.55365169481;29808.85095574508;30243.092707218817;30663.84668076645;40687.1862562753;48389.5161048385;48513.5148648509;49300.506994929594;49323.26015109848;399805;411803;412749.93625031685;574803;576726.1163694154;24698;24975.125870594442;25015.749842501344;25062.874685626455;25109.748902510742;42955;43213.567864320954;43562;43566.12867742564;44470;36029.819850900574;36117.27765444624;36416.45375319319;37307;37309.62690373061;36014.27176144614;36171.819140904125;37072.88781336564;37202.25746949519;37514.624853752204;34833;35485.64514354823;35779.642203577634;35825.238349972875;36136.63863361333;31168.22079448032;32354.35291294208;32374.676253238107;32513.187170320933;32513.187170320933;23872.164474243316;24002;24278.63582046306;24516;24582.87708561446 06:04:55 INFO - PROCESS | 1650 | |2;jquery.html;332.95068851220736;350.1054804973292;372.157064249475;373.58345444829024;400.84567441535;14779.704405911889;14947.476838310648;16164.676706465863;20230.29193978211;20284.797152028474;17375.304987800504;18632.813671863278;18668.53328666784;18884.43346699598;18890.52773680655;5030.974845125778;5317.9468205317835;5323.254744335796;5325.573954083683;5331.840044798662;4848.957474143059;5198.064348417283;5277.947220527784;5309.681419114865;5331.520163185312;5251.921221181686;5343.438938911417;5346.946530534684;5350.35795704516;5369.785208591671;4965.155923493015;4976.02967421353;5240.9475905241225;5263.657862238981;5325.961437519685;4385.276429389147;5108.770105345268;5112.565431938289;5115.2327150927285;5115.565176959963;12691.555795547203;26485;27240;27477.45045099107;28454.715452845412;2191.3316438486254;2336.8130549555995;2441.694788151481;2474.7525247475287;2734.6991830898587;12235.843083687681;14098.660627240395;16253.349866005346;16506;16897;1945.7178709087245;2034.1988474201455;2055.3628375203584;2060.6599911014664;2065.0913598016823;114085;118822.43532693946;120566;127061.30444342259;130291;20113.29603463872;20435.358508484802;20483.897580512003;20591.176352946015;20758.481037974172;33956;34060.48909266363;34061.659383406346;34184;34184.48723269153;10034.996500349907;10229.079382855578;10405.271630985759;10449.529771160163;10568.573242612303;8459;8468.957655211807;8482.10937851529;8640.524771137647;8656.177663121993;7462.900885823373;9386.389884657476;9517.428954262767;9537;9585.568649410794;3601.243738814826;3681.318955993096;3686.5207523021836;3687.8241837316114;3690.760100593453;775.4378075894931;803.7227156630953;843.4770442325674;863.8185980943947;897.6274845938992;20110.597788044157;20831.791682082985;20959.37121886346;21008.684869726967;21023.587805719402;876.2114097312469;879.907609700985;883.8762573239752;954.5275088830934;979.9167070798919;10427.426491542887;10881.619143329945;10889.401082940514;10891;10897.291676041032;539916.3004184954;547171;550356;560336;560729;94864;131256;133962.49770995483;134817;137194;935.862926544252;950.9952450237843;961.0629636104742;962;965.2519297544319;17837.375691850724;18383.90808045951;18547.072646367356;18571.350002749838;18594.977276249938;54258.18612720734;55192.724036379564;56005;56474;56950;78877.60561197158;79564.60217699106;81971;82913;83191;5798.333191682842;6699.464042876656;7794.92205077942;8107.351411886917;8171.959140204261;11546.42267886619;12496.937515312366;12579.874201258237;12864.292463914575;12868.678283042998;10887.455627218766;10907.509162087566;11066.114710823276;11078.723031924266;11111.777764444827;9106.817863642822;10962.890371096188;11011.559537618405;11125.443727813416;11294.548218071513;8890.866637000321;11031.393273370042;11045.834312485158;11104.5558177672;11392.03167730719;7720.420968427503;7979.241972012649;7979.9202007979175;8123.7156699515235;8339.583020849055;8084.272415482635;9535.094166054214;10348.637797677045;10745.946270268598;11283.830742538705 06:04:55 INFO - PROCESS | 1650 | |3;mootools.html;1326.728020755745;1419.7231539849731;1449.833269174045;1584.437524678739;1787.9821201787986;7361.668724907378;7731.574763388011;7871.763847084582;8152.633131509081;8190.91809081909;6890.689918953659;8004.119546849856;8104.351651867852;8105.837883242331;8110.513369197837;2007.1971211515438;2239.3505883293824;2268.0587556164173;2273.7498875123724;2273.8067264282554;1960.3138901384543;2091.3098677436487;2228.687983682286;2296.4832912594698;2308.8152947764224;2237.429455488856;2254.5603607296584;2256.8420210585264;2261.6607508873635;2261.8982145803398;2080.7411516032885;2089.676100204463;2114.12263910477;2121.352987338861;2257.164849005862;2264.4225722440674;2272.534130503243;2289.427643089228;2289.5420915816735;2294.1740973249616;8079.676812927476;8153;8177.4684645497855;8182.304504117157;8188.672453101869;4947.653664243504;5097.541221290065;5101.948980510185;5106.463821298785;5112.386513618352;3179.952300715491;3406.114410253327;3449.085992212066;3456.6197718250974;3464.9133771655656;993.2103977337962;1050.2753100360726;1063.744701271697;1082.0153660169208;1085.8262677971566;10646.73383165427;10671.679849604447;10679.626213082505;10695.679129626124;10732.302400343953;4434.5343738907595;4486.461624605068;4595.149897268949;4657.997061263622;4659.673822832437;9287.535623218811;9292.814143717087;9305.813883722287;9316.161545460942;9323.347365684336;5078.898422031539;5153.5361817436615;5161.122609156452;5177.715225662625;5182.559482444034;4586.3579098926175;4656.3946686930485;4685.086408150446;4719.4100737407825;4739.170645137087;3647.7993710345654;3713.628637136319;3746.4754934309217;3776.339140650375;3783.281176576442;1236.1285293867802;1238.975220495585;1241.528219276669;1258.2953546014262;1259.8425196850394;755.2598453515585;815.5125091325549;841.9115992820788;894.8836651235298;912.9087091290951;4484.820607175741;5349.1976203569775;5452.400235974119;5521.5306698930235;5713.914291285634;778.8325510015374;798.9653398848506;867.3884911137759;899.6941040046415;951.3435729346728;3239.53123833696;3608.693261072838;3718.7356298858517;3767.321882061255;3876.321643712339;9599.184069354043;9895.059969302905;9963.80072398548;9970.651027214013;9992.200623950066;9920.751981200528;9925.007499250161;9930.851037234448;9938;9943.651972180938;7360.227176146427;7595.5442673438665;7607.31534161917;7763;7779.961100194576;5424.891502170013;5522.723863806874;5552.666839989613;5568.470995255444;5744.511716504144;9223.400478968846;9256.676016339396;9264.490453024879;9266.44401335922;9275.16523512887;8571.22858942698;9109.544522773702;9388.061193880558;9512.95585412689;9544.665936692183;6237.251529816451;6460.806175814733;6495.285518593046;6593.736250549924;6682.031105489579;7726.884096738666;7843.294103530481;7845.646945887563;7957.721479748181;7960.880586791319;7091.858162836817;7131.179914309713;7159.355657990805;7175.46184036189;7185.82035449097;6920.204176519765;6961.547499412724;7001;7061.5409998352;7072.186698529735;6438.581492202992;6508.381703738138;6570.507211959218;6571.3757193066585;6573.769918052845;4722.1028004679;4803.855884323476;4809.989902120454;4851.539103785135;4964.826231081895;4716.858494245178;4829.44461386945;4894.9021019578695;4940.209566469348;5003.724795136302 06:04:55 INFO - PROCESS | 1650 | |4;prototype.html;296.8486072103227;299.3772952259301;305.64392482757586;311.37258424275075;312.8170020537985;5086.33877595913;5320.707361095138;5332.840014799557;5345.556699691081;5434.755436005385;4804.279358096287;4985.027919555688;5060.544550990419;5167.095758242312;5304.9204261936;3668.6514781095752;3930.5456980916956;4038;4067.4102255173057;4116.094459218967;3405.4551271796518;4056.3307054336;4063.3949589911967;4136.3381858902585;4159.400374765772;3946.0541918215254;4002.4996875390575;4024.6176613221696;4071.5928407159195;4080.4083407905837;3454.447288433864;3920.5099362579676;3975.912645860917;4021.3967904814367;4049.1699201663587;2924.4735947529434;3482.495038219444;3526.7883926964464;3541;3565.1978304881195;5058.620603454719;5105.489451054902;5140.254663073833;5143.27994080829;5146.408163061221;4296.677749168824;4340.370646256307;4378.949052227443;4567.200739870509;4680.227762419197;4532.524084971096;4773.689710168828;5256.9737151314;5488.890222195534;5519.448055194448;3273.852676629557;3398.9830050849837;3849.615038496156;3882.786446745456;3884.4173373993845;5041.395032596075;5603.187537807036;5710.2862142232225;5776.826695199193;5789.942100579025;3275.2630658101734;3524.69586253088;3902.8339271704476;3912.374020156761;3924.823382947774;3291.341731653679;3379.695827375548;3519.1026288296835;3620.6922411594783;3945.881623551298;3741.447299370785;4093.283675356801;4229.53475117743;4560.657950653715;4562.840300589463;5077.933633936915;5300.867478312995;5427.48438898304;5628.85927851807;5686.147077938343;1092.0771947704177;1115.5649296774266;1139.658102569226;1293.615831060756;1315.1254415813569;735.543962743092;840.3025488844245;853.114616697094;856.4090777363599;860.7089365951074;4308.3968244445805;4794.904101917942;5049.772760225798;5295.034780522919;5333.519983201453;5793.478586927196;5800.796972106041;5817.738201780845;5820.060869260996;5825.271841019872;4953.554180123806;5204.34945631796;5294.788208471695;5304.623685459512;5395.271638328853;2605.89576416945;2870.1630956188055;2879.9856000720283;2881.591165516763;2907.8400687962367;4819.7108173509705;5494.36814766307;5684.514443561982;5700.572457065737;5702.914456283159;5180.896382072413;5858.648481091148;5859.912101318484;5959.361175676637;5978.671173085435;6023.554346956699;6031.577789554689;6032.638041717511;6061.818145455643;6162.753489860445;5520.0490937120685;5736.225609542826;5778.364379918122;5847.502962248256;5955.791547295824;4698.882527936829;5442.428545002717;5667.449647658487;5698.458646428583;5745.414563446382;5591.384947655673;5902.852428689145;5924.911126333194;5987.401259873977;6130.846728831815;3439.226174110805;3857.459955606161;3933.252681990413;3960.960390396059;3982.4623675803396;4500.752458614807;4722.811087556596;5750.539956803529;5773.595848290579;5805.274340707411;5404.297441332602;5604.637217669366;5608.569814697226;5608.6073974821375;5623.8594035149445;5548.278723765885;5556.583256255716;5563.693996830213;5573.916391254215;5623;5367.704776237344;5493.752781124779;5517.7585043364925;5517.779288828402;5550.250716153268;4893.853184404474;5464.775782288469;5558.91661625084;5621.381648018633;5767.394423585463;5522.944770552243;5525.11598144295;5547.667139971614;5549.694766787704;5563.1071842640795 06:04:55 INFO - PROCESS | 1650 | |5;yui.html;672.5057083043963;706.3078183380287;719.7302988660293;770.9691612335507;780.8711562592173;14658.926705366472;15262.00796948199;15769.369225230992;15788.605284867885;16049.197540123005;13968.650783730413;14414.783778243334;14578.854211457883;14582.562523124298;14608.780868286984;796.9760907172794;826.3760860550276;828.2090603473698;832.8251067275879;833.1085738260064;646.7606985415403;670.125486240456;672.3814091036234;801.5511313664366;833.1751565949696;852.2755657690944;856.5417501636625;856.7900864288258;857.8112815180682;861.2076889261863;756.3079781999464;847.9364047696386;850.0182289455688;850.5577099908044;852.2372476633441;505.8861756104847;519.6674128557726;612.3294991983771;627.7551754815626;628.0861346740481;14379.35292911811;14997.625059373493;15003.099814011195;15015.32431040595;15025.474108406153;13728.382222799997;13830.792538111837;13999.300034998209;14091.295435228198;14101.576952691334;12691.238525688488;12720.300383478905;12734;12800.103992720513;12918.741625167444;4292.377605247221;4459.130469558438;4539.364488971547;4543.840965566223;4603.83886563972;119636;120366.2055925961;121163.99999999911;122370.16444753336;124131;9602.279829012852;10668.679939601669;10703.83944240837;10824.134069274596;11019.669409917555;19559.511012224808;20528.281510147073;21680.34958951234;21731.45671358197;21733.80464074491;7720.343770779435;7794.766157015299;7914.762557123296;7914.841703165905;8010.759677209693;4265.55211702773;4413.514513403523;4443.7111587746695;4469.10617876426;4580.770961451914;3519.5776506819348;3602.3875941090078;3625.075605720577;3626.4741612466046;3632.636736326346;646.977355792545;665.9433948114464;674.5312008154384;694.1254019934818;698.8776964031274;483.40937062867823;516.3210378352454;656.7537173559915;656.9113169722026;692.8337199072187;8808.427452215585;9235.12266334697;9384.812303753886;9491.762705932408;9499.275319157417;561.9887602248014;632.294991084937;651.7458191305394;661.1141070964931;670.1388715500558;4583.197940360424;4583.335416364608;4601.24079526881;4614.97692511542;4684.180268453007;117068.8293117075;119521.40239298748;120426;121759;122620.38689806494;89538.10461895428;91642.16715665649;100380;101536;103137.48431257796;74172;75999;77880.2211977873;81912.9999999988;82945.58527207325;7448.733715268526;7453.062203826936;9566.9043309566;9715.785526809148;9721;51477.7426112867;51578.22632660438;57070.42929570817;58078;59361.5185504753;79967;80440.74931382966;81177.18822811932;83290.16968812126;83823.58088209764;12574.371281436075;13740.93129534346;13784.862151378358;13948.651283717989;14108.647283817987;14812.185329806533;15122;15143.848561514684;15160.696786064438;15816.920915395349;13819.101758385672;13910.791338129733;14210.005299628927;14572.927135364256;14729.705405892037;14054.789178162131;14146.292685365896;14165.853078337423;14171.149731016172;14236.572902812932;13063.869361306266;13536;13837.79243311331;13891.305434728021;13942.442302307794;11245.325280483197;11522.942385288019;11600.071994240609;11649.650510484698;11825.408729563316;10412.791744165226;11285.589301337333;11323.886761132284;11433.917619163098;11569.247998880046 06:04:55 INFO - PROCESS | 1650 | __end_tp_report 06:04:55 INFO - PROCESS | 1650 | __start_cc_report 06:04:55 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1670 06:04:55 INFO - PROCESS | 1650 | __end_cc_report 06:04:55 INFO - PROCESS | 1650 | __startTimestamp1481205895729__endTimestamp 06:04:55 INFO - PROCESS | 1650 | 06:04:55 INFO - PROCESS | 1650 | ------- Summary: start ------- 06:04:55 INFO - PROCESS | 1650 | Number of tests: 6 06:04:55 INFO - PROCESS | 1650 | 06:04:55 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5693.42 Median:5891.62 stddev:665.66 (11.3%) stddev-sans-first:629.28 06:04:55 INFO - PROCESS | 1650 | Values: 2852.4 3333.9 3350.1 3374.9 3403.8 5506.3 5581.6 5588.7 5661.7 5698.0 5596.8 5635.9 5663.3 5679.3 5717.1 4237.6 5116.5 5124.1 5155.8 5196.8 5185.3 5271.5 5274.0 5281.0 5333.9 5116.6 5192.9 5198.6 5227.4 5271.2 5116.0 5193.8 5199.8 5202.4 5204.1 5095.2 5176.4 5178.6 5190.0 5196.0 5632.0 5635.5 5639.1 5647.4 5677.0 6136.4 6142.2 6145.8 6146.4 6147.5 6165.5 6192.5 6201.4 6203.2 6207.9 5429.6 5648.2 5726.9 5728.4 5738.3 6231.4 6261.8 6286.9 6305.3 6308.2 6117.2 6127.8 6148.5 6153.4 6162.8 6066.6 6106.5 6122.8 6124.9 6213.8 6146.5 6183.5 6191.0 6219.5 6223.8 6236.3 6250.8 6255.2 6256.7 6277.9 4812.0 4844.0 4941.3 4945.2 4967.0 4315.4 4358.7 4370.3 4415.5 4449.4 5668.9 5696.0 5701.5 5711.8 5807.5 6258.6 6288.7 6307.3 6308.8 6325.9 4519.4 5349.0 5756.1 5763.4 5764.3 5287.3 5289.7 5334.4 5348.1 5365.5 6280.6 6288.3 6302.7 6306.6 6314.0 6221.1 6275.1 6286.4 6301.8 6358.0 6224.6 6276.7 6294.5 6300.3 6306.8 6089.5 6108.2 6134.8 6185.4 6192.6 6257.2 6261.3 6268.2 6278.7 6279.2 5184.6 5868.7 6023.2 6077.0 6093.8 5923.7 5948.9 5976.2 5995.7 6002.4 5891.6 5895.1 5923.6 5928.1 5941.7 5984.3 6010.1 6042.4 6047.3 6061.3 5739.2 5802.3 5876.0 5877.4 5887.0 06:04:55 INFO - PROCESS | 1650 | 06:04:55 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:52963.74 Median:3363.64 stddev:108379.73 (3222.1%) stddev-sans-first:108612.12 06:04:55 INFO - PROCESS | 1650 | Values: 479.2 484.8 488.1 511.6 547.4 24786.8 31224.7 39283.0 39375.4 41321.7 39588.6 39855.2 39933.6 39994.8 40004.0 8449.6 9237.8 9418.0 9422.9 9448.2 8340.2 8551.4 8552.7 8559.2 10887.4 10958.6 11223.6 11226.8 11233.4 11264.6 11123.7 11191.6 11194.2 11197.0 11198.6 9440.7 11042.0 11101.3 11119.8 11124.7 38614.2 39008.9 39035.0 39060.6 39066.0 3328.1 3358.9 3368.3 3498.9 3874.1 29300.7 29676.3 29918.0 30322.2 30333.4 3151.0 3154.3 3181.8 3206.5 3267.7 458659.0 480198.0 480372.0 481932.0 483197.0 56379.7 56879.4 57007.7 57019.6 57054.4 55217.7 55246.7 55410.9 59239.0 59352.4 15077.6 15280.9 15291.9 15298.8 15320.0 11676.9 11734.1 11771.2 11798.2 11804.4 13546.9 14002.9 14370.7 15344.9 15860.4 5392.5 5903.6 6049.8 6092.6 6187.0 852.7 911.7 973.5 1001.6 1019.5 27209.0 28463.3 28653.9 28725.6 28995.4 1027.5 1042.5 1052.8 1070.0 1089.3 14765.3 14771.2 14867.4 15113.4 15169.5 182779.1 182875.0 183045.0 184355.0 184746.0 47398.8 48540.8 48647.0 55034.7 55550.2 1297.4 1314.8 1345.9 1352.0 1357.5 21382.0 29756.6 29808.9 30243.1 30663.8 40687.2 48389.5 48513.5 49300.5 49323.3 399805.0 411803.0 412749.9 574803.0 576726.1 24698.0 24975.1 25015.7 25062.9 25109.7 42955.0 43213.6 43562.0 43566.1 44470.0 36029.8 36117.3 36416.5 37307.0 37309.6 36014.3 36171.8 37072.9 37202.3 37514.6 34833.0 35485.6 35779.6 35825.2 36136.6 31168.2 32354.4 32374.7 32513.2 32513.2 23872.2 24002.0 24278.6 24516.0 24582.9 06:04:55 INFO - PROCESS | 1650 | 06:04:55 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:34796.09 Median:17267.30 stddev:92588.91 (536.2%) stddev-sans-first:92812.49 06:04:55 INFO - PROCESS | 1650 | Values: 333.0 350.1 372.2 373.6 400.8 14779.7 14947.5 16164.7 20230.3 20284.8 17375.3 18632.8 18668.5 18884.4 18890.5 5031.0 5317.9 5323.3 5325.6 5331.8 4849.0 5198.1 5277.9 5309.7 5331.5 5251.9 5343.4 5346.9 5350.4 5369.8 4965.2 4976.0 5240.9 5263.7 5326.0 4385.3 5108.8 5112.6 5115.2 5115.6 12691.6 26485.0 27240.0 27477.5 28454.7 2191.3 2336.8 2441.7 2474.8 2734.7 12235.8 14098.7 16253.3 16506.0 16897.0 1945.7 2034.2 2055.4 2060.7 2065.1 114085.0 118822.4 120566.0 127061.3 130291.0 20113.3 20435.4 20483.9 20591.2 20758.5 33956.0 34060.5 34061.7 34184.0 34184.5 10035.0 10229.1 10405.3 10449.5 10568.6 8459.0 8469.0 8482.1 8640.5 8656.2 7462.9 9386.4 9517.4 9537.0 9585.6 3601.2 3681.3 3686.5 3687.8 3690.8 775.4 803.7 843.5 863.8 897.6 20110.6 20831.8 20959.4 21008.7 21023.6 876.2 879.9 883.9 954.5 979.9 10427.4 10881.6 10889.4 10891.0 10897.3 539916.3 547171.0 550356.0 560336.0 560729.0 94864.0 131256.0 133962.5 134817.0 137194.0 935.9 951.0 961.1 962.0 965.3 17837.4 18383.9 18547.1 18571.4 18595.0 54258.2 55192.7 56005.0 56474.0 56950.0 78877.6 79564.6 81971.0 82913.0 83191.0 5798.3 6699.5 7794.9 8107.4 8172.0 11546.4 12496.9 12579.9 12864.3 12868.7 10887.5 10907.5 11066.1 11078.7 11111.8 9106.8 10962.9 11011.6 11125.4 11294.5 8890.9 11031.4 11045.8 11104.6 11392.0 7720.4 7979.2 7979.9 8123.7 8339.6 8084.3 9535.1 10348.6 10745.9 11283.8 06:04:55 INFO - PROCESS | 1650 | 06:04:55 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5338.98 Median:5387.04 stddev:2934.15 (54.5%) stddev-sans-first:2926.89 06:04:55 INFO - PROCESS | 1650 | Values: 1326.7 1419.7 1449.8 1584.4 1788.0 7361.7 7731.6 7871.8 8152.6 8190.9 6890.7 8004.1 8104.4 8105.8 8110.5 2007.2 2239.4 2268.1 2273.7 2273.8 1960.3 2091.3 2228.7 2296.5 2308.8 2237.4 2254.6 2256.8 2261.7 2261.9 2080.7 2089.7 2114.1 2121.4 2257.2 2264.4 2272.5 2289.4 2289.5 2294.2 8079.7 8153.0 8177.5 8182.3 8188.7 4947.7 5097.5 5101.9 5106.5 5112.4 3180.0 3406.1 3449.1 3456.6 3464.9 993.2 1050.3 1063.7 1082.0 1085.8 10646.7 10671.7 10679.6 10695.7 10732.3 4434.5 4486.5 4595.1 4658.0 4659.7 9287.5 9292.8 9305.8 9316.2 9323.3 5078.9 5153.5 5161.1 5177.7 5182.6 4586.4 4656.4 4685.1 4719.4 4739.2 3647.8 3713.6 3746.5 3776.3 3783.3 1236.1 1239.0 1241.5 1258.3 1259.8 755.3 815.5 841.9 894.9 912.9 4484.8 5349.2 5452.4 5521.5 5713.9 778.8 799.0 867.4 899.7 951.3 3239.5 3608.7 3718.7 3767.3 3876.3 9599.2 9895.1 9963.8 9970.7 9992.2 9920.8 9925.0 9930.9 9938.0 9943.7 7360.2 7595.5 7607.3 7763.0 7780.0 5424.9 5522.7 5552.7 5568.5 5744.5 9223.4 9256.7 9264.5 9266.4 9275.2 8571.2 9109.5 9388.1 9513.0 9544.7 6237.3 6460.8 6495.3 6593.7 6682.0 7726.9 7843.3 7845.6 7957.7 7960.9 7091.9 7131.2 7159.4 7175.5 7185.8 6920.2 6961.5 7001.0 7061.5 7072.2 6438.6 6508.4 6570.5 6571.4 6573.8 4722.1 4803.9 4810.0 4851.5 4964.8 4716.9 4829.4 4894.9 4940.2 5003.7 06:04:55 INFO - PROCESS | 1650 | 06:04:55 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4523.14 Median:5144.84 stddev:1432.81 (27.8%) stddev-sans-first:1401.28 06:04:55 INFO - PROCESS | 1650 | Values: 296.8 299.4 305.6 311.4 312.8 5086.3 5320.7 5332.8 5345.6 5434.8 4804.3 4985.0 5060.5 5167.1 5304.9 3668.7 3930.5 4038.0 4067.4 4116.1 3405.5 4056.3 4063.4 4136.3 4159.4 3946.1 4002.5 4024.6 4071.6 4080.4 3454.4 3920.5 3975.9 4021.4 4049.2 2924.5 3482.5 3526.8 3541.0 3565.2 5058.6 5105.5 5140.3 5143.3 5146.4 4296.7 4340.4 4378.9 4567.2 4680.2 4532.5 4773.7 5257.0 5488.9 5519.4 3273.9 3399.0 3849.6 3882.8 3884.4 5041.4 5603.2 5710.3 5776.8 5789.9 3275.3 3524.7 3902.8 3912.4 3924.8 3291.3 3379.7 3519.1 3620.7 3945.9 3741.4 4093.3 4229.5 4560.7 4562.8 5077.9 5300.9 5427.5 5628.9 5686.1 1092.1 1115.6 1139.7 1293.6 1315.1 735.5 840.3 853.1 856.4 860.7 4308.4 4794.9 5049.8 5295.0 5333.5 5793.5 5800.8 5817.7 5820.1 5825.3 4953.6 5204.3 5294.8 5304.6 5395.3 2605.9 2870.2 2880.0 2881.6 2907.8 4819.7 5494.4 5684.5 5700.6 5702.9 5180.9 5858.6 5859.9 5959.4 5978.7 6023.6 6031.6 6032.6 6061.8 6162.8 5520.0 5736.2 5778.4 5847.5 5955.8 4698.9 5442.4 5667.4 5698.5 5745.4 5591.4 5902.9 5924.9 5987.4 6130.8 3439.2 3857.5 3933.3 3961.0 3982.5 4500.8 4722.8 5750.5 5773.6 5805.3 5404.3 5604.6 5608.6 5608.6 5623.9 5548.3 5556.6 5563.7 5573.9 5623.0 5367.7 5493.8 5517.8 5517.8 5550.3 4893.9 5464.8 5558.9 5621.4 5767.4 5522.9 5525.1 5547.7 5549.7 5563.1 06:04:55 INFO - PROCESS | 1650 | 06:04:55 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:22257.04 Median:4451.42 stddev:33433.58 (751.1%) stddev-sans-first:33488.09 06:04:55 INFO - PROCESS | 1650 | Values: 672.5 706.3 719.7 771.0 780.9 14658.9 15262.0 15769.4 15788.6 16049.2 13968.7 14414.8 14578.9 14582.6 14608.8 797.0 826.4 828.2 832.8 833.1 646.8 670.1 672.4 801.6 833.2 852.3 856.5 856.8 857.8 861.2 756.3 847.9 850.0 850.6 852.2 505.9 519.7 612.3 627.8 628.1 14379.4 14997.6 15003.1 15015.3 15025.5 13728.4 13830.8 13999.3 14091.3 14101.6 12691.2 12720.3 12734.0 12800.1 12918.7 4292.4 4459.1 4539.4 4543.8 4603.8 119636.0 120366.2 121164.0 122370.2 124131.0 9602.3 10668.7 10703.8 10824.1 11019.7 19559.5 20528.3 21680.3 21731.5 21733.8 7720.3 7794.8 7914.8 7914.8 8010.8 4265.6 4413.5 4443.7 4469.1 4580.8 3519.6 3602.4 3625.1 3626.5 3632.6 647.0 665.9 674.5 694.1 698.9 483.4 516.3 656.8 656.9 692.8 8808.4 9235.1 9384.8 9491.8 9499.3 562.0 632.3 651.7 661.1 670.1 4583.2 4583.3 4601.2 4615.0 4684.2 117068.8 119521.4 120426.0 121759.0 122620.4 89538.1 91642.2 100380.0 101536.0 103137.5 74172.0 75999.0 77880.2 81913.0 82945.6 7448.7 7453.1 9566.9 9715.8 9721.0 51477.7 51578.2 57070.4 58078.0 59361.5 79967.0 80440.7 81177.2 83290.2 83823.6 12574.4 13740.9 13784.9 13948.7 14108.6 14812.2 15122.0 15143.8 15160.7 15816.9 13819.1 13910.8 14210.0 14572.9 14729.7 14054.8 14146.3 14165.9 14171.1 14236.6 13063.9 13536.0 13837.8 13891.3 13942.4 11245.3 11522.9 11600.1 11649.7 11825.4 10412.8 11285.6 11323.9 11433.9 11569.2 06:04:55 INFO - PROCESS | 1650 | -------- Summary: end -------- 06:04:55 INFO - PROCESS | 1650 | 06:04:56 INFO - TEST-INFO | 1650: exit 0 06:04:56 INFO - TEST-OK | dromaeo_css | took 1120084ms 06:04:56 INFO - TEST-START | kraken 06:04:56 INFO - operating with platform_type : mac_ 06:04:56 INFO - Initialising browser for kraken test... 06:04:56 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/tmpdx6Asb/profile http://localhost:49247/getInfo.html) 06:04:59 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 06:04:59 INFO - PROCESS | 1656 | colorDepth:24 06:04:59 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 06:04:59 INFO - PROCESS | 1656 | __metrics 06:04:59 INFO - PROCESS | 1656 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:04:59 INFO - PROCESS | 1656 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:05:00 INFO - TEST-INFO | 1656: exit 0 06:05:00 INFO - Browser initialized. 06:05:00 INFO - Running cycle 1/1 for kraken test... 06:05:00 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/tmpdx6Asb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:05:12 INFO - PROCESS | 1658 | RSS: Main: 243740672 06:05:12 INFO - PROCESS | 1658 | 06:05:15 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection) 06:05:15 INFO - PROCESS | 1658 | RSS: Main: 293490688 06:05:15 INFO - PROCESS | 1658 | 06:05:18 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-dft) 06:05:19 INFO - PROCESS | 1658 | RSS: Main: 295587840 06:05:19 INFO - PROCESS | 1658 | 06:05:22 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-fft) 06:05:23 INFO - PROCESS | 1658 | RSS: Main: 386646016 06:05:23 INFO - PROCESS | 1658 | 06:05:25 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator) 06:05:25 INFO - PROCESS | 1658 | RSS: Main: 290762752 06:05:25 INFO - PROCESS | 1658 | 06:05:27 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:05:28 INFO - PROCESS | 1658 | RSS: Main: 294178816 06:05:28 INFO - PROCESS | 1658 | 06:05:31 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom) 06:05:31 INFO - PROCESS | 1658 | RSS: Main: 335384576 06:05:31 INFO - PROCESS | 1658 | 06:05:34 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate) 06:05:35 INFO - PROCESS | 1658 | RSS: Main: 339673088 06:05:35 INFO - PROCESS | 1658 | 06:05:38 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial) 06:05:38 INFO - PROCESS | 1658 | RSS: Main: 335011840 06:05:38 INFO - PROCESS | 1658 | 06:05:40 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:05:40 INFO - PROCESS | 1658 | RSS: Main: 308703232 06:05:40 INFO - PROCESS | 1658 | 06:05:42 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:05:43 INFO - PROCESS | 1658 | RSS: Main: 313835520 06:05:43 INFO - PROCESS | 1658 | 06:05:45 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:05:46 INFO - PROCESS | 1658 | RSS: Main: 315576320 06:05:46 INFO - PROCESS | 1658 | 06:05:49 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:05:50 INFO - PROCESS | 1658 | RSS: Main: 332091392 06:05:50 INFO - PROCESS | 1658 | 06:05:52 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:05:53 INFO - PROCESS | 1658 | RSS: Main: 326471680 06:05:53 INFO - PROCESS | 1658 | 06:05:55 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49247/tests/kraken/driver.html?testName=ai-astar) 06:05:55 INFO - PROCESS | 1658 | RSS: Main: 370380800 06:05:55 INFO - PROCESS | 1658 | 06:05:55 INFO - PROCESS | 1658 | __start_tp_report 06:05:55 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 06:05:55 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 06:05:55 INFO - PROCESS | 1658 | |i|pagename|runs| 06:05:55 INFO - PROCESS | 1658 | |0;ai-astar;112;114;115;115;114;115;113;115;113;114 06:05:55 INFO - PROCESS | 1658 | |1;audio-beat-detection;142;115;113;152;139;141;113;110;149;140 06:05:55 INFO - PROCESS | 1658 | |2;audio-dft;185;184;198;261;182;184;180;183;183;184 06:05:55 INFO - PROCESS | 1658 | |3;audio-fft;82;56;60;86;51;55;78;81;99;83 06:05:55 INFO - PROCESS | 1658 | |4;audio-oscillator;85;71;87;69;68;70;82;68;70;83 06:05:55 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;87;84;87;84;87;83;87;84;87;85 06:05:55 INFO - PROCESS | 1658 | |6;imaging-darkroom;93;93;93;93;102;93;93;93;94;93 06:05:55 INFO - PROCESS | 1658 | |7;imaging-desaturate;82;88;86;95;86;85;84;86;86;85 06:05:55 INFO - PROCESS | 1658 | |8;json-parse-financial;55;53;53;54;54;56;55;55;56;54 06:05:55 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;64;78;74;74;71;69;69;70;73;71 06:05:55 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;88;88;96;98;88;87;87;86;87;87 06:05:55 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;148;143;136;165;154;153;146;146;192;145 06:05:55 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;173;158;222;202;167;170;172;173;172;173 06:05:55 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;68;69;69;79;86;87;88;72;66;67 06:05:55 INFO - PROCESS | 1658 | __end_tp_report 06:05:55 INFO - PROCESS | 1658 | __start_cc_report 06:05:55 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1948 06:05:55 INFO - PROCESS | 1658 | __end_cc_report 06:05:55 INFO - PROCESS | 1658 | __startTimestamp1481205955724__endTimestamp 06:05:55 INFO - PROCESS | 1658 | 06:05:55 INFO - PROCESS | 1658 | ------- Summary: start ------- 06:05:55 INFO - PROCESS | 1658 | Number of tests: 14 06:05:55 INFO - PROCESS | 1658 | 06:05:55 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.50 stddev:1.05 (0.9%) stddev-sans-first:0.83 06:05:55 INFO - PROCESS | 1658 | Values: 112.0 114.0 115.0 115.0 114.0 115.0 113.0 115.0 113.0 114.0 06:05:55 INFO - PROCESS | 1658 | 06:05:55 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:131.40 Median:140.50 stddev:16.58 (11.8%) stddev-sans-first:17.14 06:05:55 INFO - PROCESS | 1658 | Values: 142.0 115.0 113.0 152.0 139.0 141.0 113.0 110.0 149.0 140.0 06:05:55 INFO - PROCESS | 1658 | 06:05:55 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:192.40 Median:184.00 stddev:24.59 (13.4%) stddev-sans-first:25.94 06:05:55 INFO - PROCESS | 1658 | Values: 185.0 184.0 198.0 261.0 182.0 184.0 180.0 183.0 183.0 184.0 06:05:55 INFO - PROCESS | 1658 | 06:05:55 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:73.10 Median:81.50 stddev:16.26 (20.0%) stddev-sans-first:16.93 06:05:55 INFO - PROCESS | 1658 | Values: 82.0 56.0 60.0 86.0 51.0 55.0 78.0 81.0 99.0 83.0 06:05:55 INFO - PROCESS | 1658 | 06:05:55 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:75.30 Median:76.50 stddev:7.86 (10.3%) stddev-sans-first:7.51 06:05:55 INFO - PROCESS | 1658 | Values: 85.0 71.0 87.0 69.0 68.0 70.0 82.0 68.0 70.0 83.0 06:05:55 INFO - PROCESS | 1658 | 06:05:55 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:85.50 Median:87.00 stddev:1.65 (1.9%) stddev-sans-first:1.66 06:05:55 INFO - PROCESS | 1658 | Values: 87.0 84.0 87.0 84.0 87.0 83.0 87.0 84.0 87.0 85.0 06:05:55 INFO - PROCESS | 1658 | 06:05:55 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:94.00 Median:93.00 stddev:2.83 (3.0%) stddev-sans-first:2.98 06:05:55 INFO - PROCESS | 1658 | Values: 93.0 93.0 93.0 93.0 102.0 93.0 93.0 93.0 94.0 93.0 06:05:55 INFO - PROCESS | 1658 | 06:05:55 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:86.30 Median:86.00 stddev:3.43 (4.0%) stddev-sans-first:3.27 06:05:55 INFO - PROCESS | 1658 | Values: 82.0 88.0 86.0 95.0 86.0 85.0 84.0 86.0 86.0 85.0 06:05:55 INFO - PROCESS | 1658 | 06:05:55 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:1.08 (2.0%) stddev-sans-first:1.13 06:05:55 INFO - PROCESS | 1658 | Values: 55.0 53.0 53.0 54.0 54.0 56.0 55.0 55.0 56.0 54.0 06:05:55 INFO - PROCESS | 1658 | 06:05:55 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:72.00 stddev:3.77 (5.2%) stddev-sans-first:2.93 06:05:55 INFO - PROCESS | 1658 | Values: 64.0 78.0 74.0 74.0 71.0 69.0 69.0 70.0 73.0 71.0 06:05:55 INFO - PROCESS | 1658 | 06:05:55 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:89.20 Median:88.00 stddev:4.18 (4.8%) stddev-sans-first:4.42 06:05:55 INFO - PROCESS | 1658 | Values: 88.0 88.0 96.0 98.0 88.0 87.0 87.0 86.0 87.0 87.0 06:05:55 INFO - PROCESS | 1658 | 06:05:55 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:152.80 Median:150.50 stddev:15.78 (10.5%) stddev-sans-first:16.64 06:05:55 INFO - PROCESS | 1658 | Values: 148.0 143.0 136.0 165.0 154.0 153.0 146.0 146.0 192.0 145.0 06:05:55 INFO - PROCESS | 1658 | 06:05:55 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.20 Median:173.00 stddev:18.98 (11.0%) stddev-sans-first:20.04 06:05:55 INFO - PROCESS | 1658 | Values: 173.0 158.0 222.0 202.0 167.0 170.0 172.0 173.0 172.0 173.0 06:05:55 INFO - PROCESS | 1658 | 06:05:55 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.10 Median:75.50 stddev:8.97 (11.9%) stddev-sans-first:9.14 06:05:55 INFO - PROCESS | 1658 | Values: 68.0 69.0 69.0 79.0 86.0 87.0 88.0 72.0 66.0 67.0 06:05:55 INFO - PROCESS | 1658 | -------- Summary: end -------- 06:05:55 INFO - PROCESS | 1658 | 06:05:56 INFO - TEST-INFO | 1658: exit 0 06:05:56 INFO - TEST-OK | kraken | took 60389ms 06:05:56 INFO - SUITE-END | took 1180s 06:05:56 INFO - Completed test suite (00:19:40) 06:05:56 INFO - javascript benchmark 06:05:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2852.3724780548278, 3333.9166520836993, 3350.0787283497034, 3374.9031564741467, 3403.8127902965343, 5506.311711036121, 5581.581381396396, 5588.692621905793, 5661.716914154291, 5698.03133467311, 5596.832095037155, 5635.915461268074, 5663.292088488939, 5679.346875109363, 5717.056685646874, 4237.639800616951, 5116.488351164891, 5124.128898087315, 5155.76799044042, 5196.766145523442, 5185.299984502081, 5271.472852714736, 5274.024305503494, 5281.0, 5333.946660533384, 5116.641835071547, 5192.92210616841, 5198.610104242159, 5227.372715274153, 5271.15661494161, 5115.974420127913, 5193.766280517386, 5199.792008319662, 5202.401723801736, 5204.089284375219, 5095.217183008633, 5176.378834539842, 5178.559822415099, 5190.039842629088, 5195.986782577399, 5632.014397480424, 5635.520980716644, 5639.097744360924, 5647.37878833328, 5676.97814393409, 6136.3783883643555, 6142.174599684151, 6145.832291864576, 6146.354632763585, 6147.508199344042, 6165.537584681167, 6192.473639740628, 6201.441870231701, 6203.162573052626, 6207.906881396782, 5429.647072940246, 5648.181013753024, 5726.856828579277, 5728.427157284238, 5738.282714660668, 6231.4391704746795, 6261.78083767066, 6286.874262514724, 6305.306416294204, 6308.243010838729, 6117.235345581802, 6127.84680382994, 6148.538859585549, 6153.353897840751, 6162.7843025494785, 6066.575339726265, 6106.460667179974, 6122.755089796358, 6124.908126378108, 6213.782517611952, 6146.5390095743, 6183.474404675653, 6190.978488549429, 6219.533534984895, 6223.782167624111, 6236.345183755731, 6250.781222657276, 6255.186825712628, 6256.655883926428, 6277.8744425111245, 4811.975940120277, 4844.0, 4941.332920055746, 4945.184044632667, 4966.9817687374725, 4315.438992930899, 4358.670605465363, 4370.344448332776, 4415.470143582791, 4449.354843547668, 5668.894565559759, 5696.031674615326, 5701.458361455655, 5711.771529138788, 5807.535397168216, 6258.624482531062, 6288.717007734663, 6307.274663413675, 6308.842278943063, 6325.9051114233325, 4519.389882365838, 5349.0, 5756.136579513023, 5763.366029736726, 5764.279465066867, 5287.259783630295, 5289.656172348785, 5334.359876814807, 5348.090824559834, 5365.517103460707, 6280.560360774702, 6288.308286088618, 6302.716377763103, 6306.590071645328, 6313.96843015782, 6221.129041934042, 6275.090111933835, 6286.4342209201395, 6301.779437719658, 6358.0, 6224.62652240867, 6276.717547710456, 6294.5279104068295, 6300.306966233619, 6306.779262725966, 6089.48239399656, 6108.159949115189, 6134.754609815557, 6185.381461853779, 6192.566520343533, 6257.186565746424, 6261.3112557617715, 6268.216472940882, 6278.7488500461295, 6279.215098112736, 5184.611154163377, 5868.67722275279, 6023.247094113236, 6077.0, 6093.817185484442, 5923.674197919156, 5948.910766338422, 5976.163337132718, 5995.730192141277, 6002.399760023963, 5891.617044892068, 5895.115732639967, 5923.585349025527, 5928.051511758098, 5941.702914854153, 5984.281886173687, 6010.098485227251, 6042.425969532887, 6047.274327080779, 6061.272647282178, 5739.196512488338, 5802.332731735735, 5875.970620146872, 5877.4122587742595, 5887.028640274307], "value": 5649.06754829982, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.1806011719959, 484.7624663914683, 488.0945845456679, 511.60350728185665, 547.4060644201041, 24786.752132478694, 31224.687753122464, 39283.0179245519, 39375.40936885949, 41321.69426445885, 39588.60411395885, 39855.202895942064, 39933.600663993355, 39994.80002599983, 40004.0, 8449.57752112395, 9237.76905577361, 9418.0, 9422.858657120149, 9448.196903263231, 8340.249377556018, 8551.358648101386, 8552.657893684276, 8559.22966932976, 10887.401192934385, 10958.616448424307, 11223.60717374892, 11226.831597526043, 11233.438328083605, 11264.605738799144, 11123.666290011313, 11191.608293709682, 11194.216404851664, 11197.048250898684, 11198.608048718337, 9440.669576564856, 11042.0, 11101.278416902875, 11119.833202501968, 11124.721881952935, 38614.22771544554, 39008.854513001774, 39035.0, 39060.60939390626, 39066.02334941621, 3328.051505320996, 3358.932821343559, 3368.34317308125, 3498.94751578724, 3874.128321127752, 29300.706992930012, 29676.258093547618, 29918.0, 30322.241943951576, 30333.393332133455, 3150.984245078783, 3154.3375891062906, 3181.793183443092, 3206.5190221466733, 3267.6895694908944, 458659.0, 480198.0, 480371.9999999965, 481932.0, 483197.0, 56379.71810140923, 56879.43120568741, 57007.71496142493, 57019.57451063757, 57054.429455704914, 55217.723911380184, 55246.723766381714, 55410.89178216413, 59239.0, 59352.40647593555, 15077.623059423602, 15280.853935954849, 15291.929564930571, 15298.847011529742, 15320.004199726982, 11676.94161529187, 11734.11994100446, 11771.176017678852, 11798.233114847679, 11804.350760708072, 13546.93226533861, 14002.929985350009, 14370.712585748226, 15344.923275383551, 15860.365585376687, 5392.544013116437, 5903.586748927534, 6049.848753781191, 6092.573519853568, 6187.0, 852.6504133305315, 911.7128104647015, 973.5424350555228, 1001.6293971230546, 1019.454591793387, 27209.0, 28463.28841778972, 28653.85673071663, 28725.56911646327, 28995.420091598473, 1027.5152404775179, 1042.4996001919121, 1052.826283663187, 1069.9518521666544, 1089.319175515303, 14765.33555989983, 14771.187584682946, 14867.405303787727, 15113.395464181529, 15169.469068582768, 182779.08610456862, 182875.0, 183045.0, 184355.0, 184746.0, 47398.763006185436, 48540.75729621329, 48647.0, 55034.72482637641, 55550.16674749882, 1297.4096785962365, 1314.8159257703928, 1345.9327033648278, 1351.9932400337934, 1357.5248662967883, 21382.0, 29756.55365169481, 29808.85095574508, 30243.092707218817, 30663.84668076645, 40687.1862562753, 48389.5161048385, 48513.5148648509, 49300.506994929594, 49323.26015109848, 399805.0, 411803.0, 412749.93625031685, 574803.0, 576726.1163694154, 24698.0, 24975.125870594442, 25015.749842501344, 25062.874685626455, 25109.748902510742, 42955.0, 43213.567864320954, 43562.0, 43566.12867742564, 44470.0, 36029.819850900574, 36117.27765444624, 36416.45375319319, 37307.0, 37309.62690373061, 36014.27176144614, 36171.819140904125, 37072.88781336564, 37202.25746949519, 37514.624853752204, 34833.0, 35485.64514354823, 35779.642203577634, 35825.238349972875, 36136.63863361333, 31168.22079448032, 32354.35291294208, 32374.676253238107, 32513.187170320933, 32513.187170320933, 23872.164474243316, 24002.0, 24278.63582046306, 24516.0, 24582.87708561446], "value": 18395.407272362165, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.95068851220736, 350.1054804973292, 372.157064249475, 373.58345444829024, 400.84567441535, 14779.704405911889, 14947.476838310648, 16164.676706465863, 20230.29193978211, 20284.797152028474, 17375.304987800504, 18632.813671863278, 18668.53328666784, 18884.43346699598, 18890.52773680655, 5030.974845125778, 5317.9468205317835, 5323.254744335796, 5325.573954083683, 5331.840044798662, 4848.957474143059, 5198.064348417283, 5277.947220527784, 5309.681419114865, 5331.520163185312, 5251.921221181686, 5343.438938911417, 5346.946530534684, 5350.35795704516, 5369.785208591671, 4965.155923493015, 4976.02967421353, 5240.9475905241225, 5263.657862238981, 5325.961437519685, 4385.276429389147, 5108.770105345268, 5112.565431938289, 5115.2327150927285, 5115.565176959963, 12691.555795547203, 26485.0, 27240.0, 27477.45045099107, 28454.715452845412, 2191.3316438486254, 2336.8130549555995, 2441.694788151481, 2474.7525247475287, 2734.6991830898587, 12235.843083687681, 14098.660627240395, 16253.349866005346, 16506.0, 16897.0, 1945.7178709087245, 2034.1988474201455, 2055.3628375203584, 2060.6599911014664, 2065.0913598016823, 114085.0, 118822.43532693946, 120566.0, 127061.30444342259, 130291.0, 20113.29603463872, 20435.358508484802, 20483.897580512003, 20591.176352946015, 20758.481037974172, 33956.0, 34060.48909266363, 34061.659383406346, 34184.0, 34184.48723269153, 10034.996500349907, 10229.079382855578, 10405.271630985759, 10449.529771160163, 10568.573242612303, 8459.0, 8468.957655211807, 8482.10937851529, 8640.524771137647, 8656.177663121993, 7462.900885823373, 9386.389884657476, 9517.428954262767, 9537.0, 9585.568649410794, 3601.243738814826, 3681.318955993096, 3686.5207523021836, 3687.8241837316114, 3690.760100593453, 775.4378075894931, 803.7227156630953, 843.4770442325674, 863.8185980943947, 897.6274845938992, 20110.597788044157, 20831.791682082985, 20959.37121886346, 21008.684869726967, 21023.587805719402, 876.2114097312469, 879.907609700985, 883.8762573239752, 954.5275088830934, 979.9167070798919, 10427.426491542887, 10881.619143329945, 10889.401082940514, 10891.0, 10897.291676041032, 539916.3004184954, 547171.0, 550356.0, 560336.0, 560729.0, 94864.0, 131256.0, 133962.49770995483, 134817.0, 137194.0, 935.862926544252, 950.9952450237843, 961.0629636104742, 962.0, 965.2519297544319, 17837.375691850724, 18383.90808045951, 18547.072646367356, 18571.350002749838, 18594.977276249938, 54258.18612720734, 55192.724036379564, 56005.0, 56474.0, 56950.0, 78877.60561197158, 79564.60217699106, 81971.0, 82913.0, 83191.0, 5798.333191682842, 6699.464042876656, 7794.92205077942, 8107.351411886917, 8171.959140204261, 11546.42267886619, 12496.937515312366, 12579.874201258237, 12864.292463914575, 12868.678283042998, 10887.455627218766, 10907.509162087566, 11066.114710823276, 11078.723031924266, 11111.777764444827, 9106.817863642822, 10962.890371096188, 11011.559537618405, 11125.443727813416, 11294.548218071513, 8890.866637000321, 11031.393273370042, 11045.834312485158, 11104.5558177672, 11392.03167730719, 7720.420968427503, 7979.241972012649, 7979.9202007979175, 8123.7156699515235, 8339.583020849055, 8084.272415482635, 9535.094166054214, 10348.637797677045, 10745.946270268598, 11283.830742538705], "value": 10163.03151175911, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1326.728020755745, 1419.7231539849731, 1449.833269174045, 1584.437524678739, 1787.9821201787986, 7361.668724907378, 7731.574763388011, 7871.763847084582, 8152.633131509081, 8190.91809081909, 6890.689918953659, 8004.119546849856, 8104.351651867852, 8105.837883242331, 8110.513369197837, 2007.1971211515438, 2239.3505883293824, 2268.0587556164173, 2273.7498875123724, 2273.8067264282554, 1960.3138901384543, 2091.3098677436487, 2228.687983682286, 2296.4832912594698, 2308.8152947764224, 2237.429455488856, 2254.5603607296584, 2256.8420210585264, 2261.6607508873635, 2261.8982145803398, 2080.7411516032885, 2089.676100204463, 2114.12263910477, 2121.352987338861, 2257.164849005862, 2264.4225722440674, 2272.534130503243, 2289.427643089228, 2289.5420915816735, 2294.1740973249616, 8079.676812927476, 8153.0, 8177.4684645497855, 8182.304504117157, 8188.672453101869, 4947.653664243504, 5097.541221290065, 5101.948980510185, 5106.463821298785, 5112.386513618352, 3179.952300715491, 3406.114410253327, 3449.085992212066, 3456.6197718250974, 3464.9133771655656, 993.2103977337962, 1050.2753100360726, 1063.744701271697, 1082.0153660169208, 1085.8262677971566, 10646.73383165427, 10671.679849604447, 10679.626213082505, 10695.679129626124, 10732.302400343953, 4434.5343738907595, 4486.461624605068, 4595.149897268949, 4657.997061263622, 4659.673822832437, 9287.535623218811, 9292.814143717087, 9305.813883722287, 9316.161545460942, 9323.347365684336, 5078.898422031539, 5153.5361817436615, 5161.122609156452, 5177.715225662625, 5182.559482444034, 4586.3579098926175, 4656.3946686930485, 4685.086408150446, 4719.4100737407825, 4739.170645137087, 3647.7993710345654, 3713.628637136319, 3746.4754934309217, 3776.339140650375, 3783.281176576442, 1236.1285293867802, 1238.975220495585, 1241.528219276669, 1258.2953546014262, 1259.8425196850394, 755.2598453515585, 815.5125091325549, 841.9115992820788, 894.8836651235298, 912.9087091290951, 4484.820607175741, 5349.1976203569775, 5452.400235974119, 5521.5306698930235, 5713.914291285634, 778.8325510015374, 798.9653398848506, 867.3884911137759, 899.6941040046415, 951.3435729346728, 3239.53123833696, 3608.693261072838, 3718.7356298858517, 3767.321882061255, 3876.321643712339, 9599.184069354043, 9895.059969302905, 9963.80072398548, 9970.651027214013, 9992.200623950066, 9920.751981200528, 9925.007499250161, 9930.851037234448, 9938.0, 9943.651972180938, 7360.227176146427, 7595.5442673438665, 7607.31534161917, 7763.0, 7779.961100194576, 5424.891502170013, 5522.723863806874, 5552.666839989613, 5568.470995255444, 5744.511716504144, 9223.400478968846, 9256.676016339396, 9264.490453024879, 9266.44401335922, 9275.16523512887, 8571.22858942698, 9109.544522773702, 9388.061193880558, 9512.95585412689, 9544.665936692183, 6237.251529816451, 6460.806175814733, 6495.285518593046, 6593.736250549924, 6682.031105489579, 7726.884096738666, 7843.294103530481, 7845.646945887563, 7957.721479748181, 7960.880586791319, 7091.858162836817, 7131.179914309713, 7159.355657990805, 7175.46184036189, 7185.82035449097, 6920.204176519765, 6961.547499412724, 7001.0, 7061.5409998352, 7072.186698529735, 6438.581492202992, 6508.381703738138, 6570.507211959218, 6571.3757193066585, 6573.769918052845, 4722.1028004679, 4803.855884323476, 4809.989902120454, 4851.539103785135, 4964.826231081895, 4716.858494245178, 4829.44461386945, 4894.9021019578695, 4940.209566469348, 5003.724795136302], "value": 4316.29690599141, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.8486072103227, 299.3772952259301, 305.64392482757586, 311.37258424275075, 312.8170020537985, 5086.33877595913, 5320.707361095138, 5332.840014799557, 5345.556699691081, 5434.755436005385, 4804.279358096287, 4985.027919555688, 5060.544550990419, 5167.095758242312, 5304.9204261936, 3668.6514781095752, 3930.5456980916956, 4038.0, 4067.4102255173057, 4116.094459218967, 3405.4551271796518, 4056.3307054336, 4063.3949589911967, 4136.3381858902585, 4159.400374765772, 3946.0541918215254, 4002.4996875390575, 4024.6176613221696, 4071.5928407159195, 4080.4083407905837, 3454.447288433864, 3920.5099362579676, 3975.912645860917, 4021.3967904814367, 4049.1699201663587, 2924.4735947529434, 3482.495038219444, 3526.7883926964464, 3541.0, 3565.1978304881195, 5058.620603454719, 5105.489451054902, 5140.254663073833, 5143.27994080829, 5146.408163061221, 4296.677749168824, 4340.370646256307, 4378.949052227443, 4567.200739870509, 4680.227762419197, 4532.524084971096, 4773.689710168828, 5256.9737151314, 5488.890222195534, 5519.448055194448, 3273.852676629557, 3398.9830050849837, 3849.615038496156, 3882.786446745456, 3884.4173373993845, 5041.395032596075, 5603.187537807036, 5710.2862142232225, 5776.826695199193, 5789.942100579025, 3275.2630658101734, 3524.69586253088, 3902.8339271704476, 3912.374020156761, 3924.823382947774, 3291.341731653679, 3379.695827375548, 3519.1026288296835, 3620.6922411594783, 3945.881623551298, 3741.447299370785, 4093.283675356801, 4229.53475117743, 4560.657950653715, 4562.840300589463, 5077.933633936915, 5300.867478312995, 5427.48438898304, 5628.85927851807, 5686.147077938343, 1092.0771947704177, 1115.5649296774266, 1139.658102569226, 1293.615831060756, 1315.1254415813569, 735.543962743092, 840.3025488844245, 853.114616697094, 856.4090777363599, 860.7089365951074, 4308.3968244445805, 4794.904101917942, 5049.772760225798, 5295.034780522919, 5333.519983201453, 5793.478586927196, 5800.796972106041, 5817.738201780845, 5820.060869260996, 5825.271841019872, 4953.554180123806, 5204.34945631796, 5294.788208471695, 5304.623685459512, 5395.271638328853, 2605.89576416945, 2870.1630956188055, 2879.9856000720283, 2881.591165516763, 2907.8400687962367, 4819.7108173509705, 5494.36814766307, 5684.514443561982, 5700.572457065737, 5702.914456283159, 5180.896382072413, 5858.648481091148, 5859.912101318484, 5959.361175676637, 5978.671173085435, 6023.554346956699, 6031.577789554689, 6032.638041717511, 6061.818145455643, 6162.753489860445, 5520.0490937120685, 5736.225609542826, 5778.364379918122, 5847.502962248256, 5955.791547295824, 4698.882527936829, 5442.428545002717, 5667.449647658487, 5698.458646428583, 5745.414563446382, 5591.384947655673, 5902.852428689145, 5924.911126333194, 5987.401259873977, 6130.846728831815, 3439.226174110805, 3857.459955606161, 3933.252681990413, 3960.960390396059, 3982.4623675803396, 4500.752458614807, 4722.811087556596, 5750.539956803529, 5773.595848290579, 5805.274340707411, 5404.297441332602, 5604.637217669366, 5608.569814697226, 5608.6073974821375, 5623.8594035149445, 5548.278723765885, 5556.583256255716, 5563.693996830213, 5573.916391254215, 5623.0, 5367.704776237344, 5493.752781124779, 5517.7585043364925, 5517.779288828402, 5550.250716153268, 4893.853184404474, 5464.775782288469, 5558.91661625084, 5621.381648018633, 5767.394423585463, 5522.944770552243, 5525.11598144295, 5547.667139971614, 5549.694766787704, 5563.1071842640795], "value": 4056.322652930003, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.5057083043963, 706.3078183380287, 719.7302988660293, 770.9691612335507, 780.8711562592173, 14658.926705366472, 15262.00796948199, 15769.369225230992, 15788.605284867885, 16049.197540123005, 13968.650783730413, 14414.783778243334, 14578.854211457883, 14582.562523124298, 14608.780868286984, 796.9760907172794, 826.3760860550276, 828.2090603473698, 832.8251067275879, 833.1085738260064, 646.7606985415403, 670.125486240456, 672.3814091036234, 801.5511313664366, 833.1751565949696, 852.2755657690944, 856.5417501636625, 856.7900864288258, 857.8112815180682, 861.2076889261863, 756.3079781999464, 847.9364047696386, 850.0182289455688, 850.5577099908044, 852.2372476633441, 505.8861756104847, 519.6674128557726, 612.3294991983771, 627.7551754815626, 628.0861346740481, 14379.35292911811, 14997.625059373493, 15003.099814011195, 15015.32431040595, 15025.474108406153, 13728.382222799997, 13830.792538111837, 13999.300034998209, 14091.295435228198, 14101.576952691334, 12691.238525688488, 12720.300383478905, 12734.0, 12800.103992720513, 12918.741625167444, 4292.377605247221, 4459.130469558438, 4539.364488971547, 4543.840965566223, 4603.83886563972, 119636.0, 120366.2055925961, 121163.99999999911, 122370.16444753336, 124131.0, 9602.279829012852, 10668.679939601669, 10703.83944240837, 10824.134069274596, 11019.669409917555, 19559.511012224808, 20528.281510147073, 21680.34958951234, 21731.45671358197, 21733.80464074491, 7720.343770779435, 7794.766157015299, 7914.762557123296, 7914.841703165905, 8010.759677209693, 4265.55211702773, 4413.514513403523, 4443.7111587746695, 4469.10617876426, 4580.770961451914, 3519.5776506819348, 3602.3875941090078, 3625.075605720577, 3626.4741612466046, 3632.636736326346, 646.977355792545, 665.9433948114464, 674.5312008154384, 694.1254019934818, 698.8776964031274, 483.40937062867823, 516.3210378352454, 656.7537173559915, 656.9113169722026, 692.8337199072187, 8808.427452215585, 9235.12266334697, 9384.812303753886, 9491.762705932408, 9499.275319157417, 561.9887602248014, 632.294991084937, 651.7458191305394, 661.1141070964931, 670.1388715500558, 4583.197940360424, 4583.335416364608, 4601.24079526881, 4614.97692511542, 4684.180268453007, 117068.8293117075, 119521.40239298748, 120426.0, 121759.0, 122620.38689806494, 89538.10461895428, 91642.16715665649, 100380.0, 101536.0, 103137.48431257796, 74172.0, 75999.0, 77880.2211977873, 81912.9999999988, 82945.58527207325, 7448.733715268526, 7453.062203826936, 9566.9043309566, 9715.785526809148, 9721.0, 51477.7426112867, 51578.22632660438, 57070.42929570817, 58078.0, 59361.5185504753, 79967.0, 80440.74931382966, 81177.18822811932, 83290.16968812126, 83823.58088209764, 12574.371281436075, 13740.93129534346, 13784.862151378358, 13948.651283717989, 14108.647283817987, 14812.185329806533, 15122.0, 15143.848561514684, 15160.696786064438, 15816.920915395349, 13819.101758385672, 13910.791338129733, 14210.005299628927, 14572.927135364256, 14729.705405892037, 14054.789178162131, 14146.292685365896, 14165.853078337423, 14171.149731016172, 14236.572902812932, 13063.869361306266, 13536.0, 13837.79243311331, 13891.305434728021, 13942.442302307794, 11245.325280483197, 11522.942385288019, 11600.071994240609, 11649.650510484698, 11825.408729563316, 10412.791744165226, 11285.589301337333, 11323.886761132284, 11433.917619163098, 11569.247998880046], "value": 7591.820326170532, "unit": "score"}], "name": "dromaeo_css", "value": 7209.264678211238, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 115.0, 115.0, 114.0, 115.0, 113.0, 115.0, 113.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 115.0, 113.0, 152.0, 139.0, 141.0, 113.0, 110.0, 149.0, 140.0], "value": 131.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 198.0, 261.0, 182.0, 184.0, 180.0, 183.0, 183.0, 184.0], "value": 192.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 56.0, 60.0, 86.0, 51.0, 55.0, 78.0, 81.0, 99.0, 83.0], "value": 73.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 87.0, 69.0, 68.0, 70.0, 82.0, 68.0, 70.0, 83.0], "value": 75.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 84.0, 87.0, 83.0, 87.0, 84.0, 87.0, 85.0], "value": 85.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 93.0, 102.0, 93.0, 93.0, 93.0, 94.0, 93.0], "value": 94.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 88.0, 86.0, 95.0, 86.0, 85.0, 84.0, 86.0, 86.0, 85.0], "value": 86.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 54.0, 54.0, 56.0, 55.0, 55.0, 56.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 78.0, 74.0, 74.0, 71.0, 69.0, 69.0, 70.0, 73.0, 71.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 96.0, 98.0, 88.0, 87.0, 87.0, 86.0, 87.0, 87.0], "value": 89.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 143.0, 136.0, 165.0, 154.0, 153.0, 146.0, 146.0, 192.0, 145.0], "value": 152.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 158.0, 222.0, 202.0, 167.0, 170.0, 172.0, 173.0, 172.0, 173.0], "value": 178.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 79.0, 86.0, 87.0, 88.0, 72.0, 66.0, 67.0], "value": 75.1, "unit": "score"}], "name": "kraken", "value": 1473.0999999999997, "alertThreshold": 2.0}]} 06:05:56 INFO - Return code: 0 06:05:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:05:57 INFO - # TBPL SUCCESS # 06:05:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:05:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:05:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:05:57 INFO - 2016-12-08 06:05:57.057 screenresolution[1662:10683] starting screenresolution argv=screenresolution get 06:05:57 INFO - 2016-12-08 06:05:57.060 screenresolution[1662:10683] Display 0: 1600x1200x32@60 06:05:57 INFO - 2016-12-08 06:05:57.067 screenresolution[1663:10686] starting screenresolution argv=screenresolution list 06:05:57 INFO - Available Modes on Display 0 06:05:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:05:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:05:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:05:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:05:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:05:57 INFO - Intel Iris: 06:05:57 INFO - Chipset Model: Intel Iris 06:05:57 INFO - Type: GPU 06:05:57 INFO - Bus: Built-In 06:05:57 INFO - VRAM (Dynamic, Max): 1536 MB 06:05:57 INFO - Vendor: Intel (0x8086) 06:05:57 INFO - Device ID: 0x0a2e 06:05:57 INFO - Revision ID: 0x0009 06:05:57 INFO - Displays: 06:05:57 INFO - Display: 06:05:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:05:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:05:57 INFO - Display Serial Number: 1600x1200 60 06:05:57 INFO - Main Display: Yes 06:05:57 INFO - Mirror: Off 06:05:57 INFO - Online: Yes 06:05:57 INFO - Rotation: Supported 06:05:57 INFO - Return code: 0 06:05:57 INFO - Running post-action listener: _resource_record_post_action 06:05:57 INFO - [mozharness: 2016-12-08 14:05:57.312687Z] Finished run-tests step (success) 06:05:57 INFO - Running post-run listener: _resource_record_post_run 06:05:57 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 32467968; Write bytes: 697170944; Read time: 200; Write time: 1997 06:05:57 INFO - TinderboxPrint: CPU usage
53.5% 06:05:57 INFO - TinderboxPrint: I/O read bytes / time
32,467,968 / 200 06:05:57 INFO - TinderboxPrint: I/O write bytes / time
697,170,944 / 1,997 06:05:57 INFO - TinderboxPrint: CPU idle
2,258.3 (46.5%) 06:05:57 INFO - TinderboxPrint: CPU system
972.3 (20.0%) 06:05:57 INFO - TinderboxPrint: CPU user
1,627.1 (33.5%) 06:05:57 INFO - TinderboxPrint: Swap in / out
412,708,864 / 0 06:05:57 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 384764416; Write bytes: 386106880; Read time: 28993; Write time: 815 06:05:57 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 29195264; Write bytes: 309614080; Read time: 176; Write time: 1177 06:05:57 INFO - Running post-run listener: _upload_blobber_files 06:05:57 INFO - Blob upload gear active. 06:05:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:05:57 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 06:05:57 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'] 06:05:57 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 06:05:58 INFO - (blobuploader) - INFO - Open directory for files ... 06:05:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:05:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:05:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:05:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:05:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:05:59 INFO - (blobuploader) - INFO - Done attempting. 06:05:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:05:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:05:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:06:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:00 INFO - (blobuploader) - INFO - Done attempting. 06:06:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:06:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:06:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:03 INFO - (blobuploader) - INFO - Done attempting. 06:06:03 INFO - (blobuploader) - INFO - Iteration through files over. 06:06:03 INFO - Return code: 0 06:06:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:06:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:06:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f95e44773a90f4aa724727bd11cbc4987705ab8cdaef5abe37ed36b67e4d2cec999a7b1d29589a80ed1fb7f557c5c45150ba3a0ea0bd6033ea88ca838086b5d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/597110fdcd54f7b93e70628620a498b09c7fc4905108fe716bd326d55d93bad50847f7cc4dbdf989c0cd6be099be7eb85d169d5fed0e3f4e124559cb68a4b0a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3955b295593ddd5e601b38e4bdfd39b665f7b4a352cb693690969327309ac5973437c0420d272a879d01bf9fe8fc5e14388e173ccb3acf2ddc834cd68c07e281"} 06:06:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:06:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:06:03 INFO - Contents: 06:06:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f95e44773a90f4aa724727bd11cbc4987705ab8cdaef5abe37ed36b67e4d2cec999a7b1d29589a80ed1fb7f557c5c45150ba3a0ea0bd6033ea88ca838086b5d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/597110fdcd54f7b93e70628620a498b09c7fc4905108fe716bd326d55d93bad50847f7cc4dbdf989c0cd6be099be7eb85d169d5fed0e3f4e124559cb68a4b0a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3955b295593ddd5e601b38e4bdfd39b665f7b4a352cb693690969327309ac5973437c0420d272a879d01bf9fe8fc5e14388e173ccb3acf2ddc834cd68c07e281"} 06:06:03 INFO - Running post-run listener: copy_logs_to_upload_dir 06:06:03 INFO - Copying logs to upload dir... 06:06:03 INFO - mkdir: /builds/slave/test/build/upload/logs 06:06:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.451100 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-12-08 06:06:03.603242) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-08 06:06:03.606821) ========= 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.Omo6nIVkg3/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.RYR72JuhNC/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f95e44773a90f4aa724727bd11cbc4987705ab8cdaef5abe37ed36b67e4d2cec999a7b1d29589a80ed1fb7f557c5c45150ba3a0ea0bd6033ea88ca838086b5d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/597110fdcd54f7b93e70628620a498b09c7fc4905108fe716bd326d55d93bad50847f7cc4dbdf989c0cd6be099be7eb85d169d5fed0e3f4e124559cb68a4b0a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3955b295593ddd5e601b38e4bdfd39b665f7b4a352cb693690969327309ac5973437c0420d272a879d01bf9fe8fc5e14388e173ccb3acf2ddc834cd68c07e281"} build_url:https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011134 build_url: 'https://queue.taskcluster.net/v1/task/at0gsR3yTQy23_nWcVreAQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f95e44773a90f4aa724727bd11cbc4987705ab8cdaef5abe37ed36b67e4d2cec999a7b1d29589a80ed1fb7f557c5c45150ba3a0ea0bd6033ea88ca838086b5d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/597110fdcd54f7b93e70628620a498b09c7fc4905108fe716bd326d55d93bad50847f7cc4dbdf989c0cd6be099be7eb85d169d5fed0e3f4e124559cb68a4b0a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3955b295593ddd5e601b38e4bdfd39b665f7b4a352cb693690969327309ac5973437c0420d272a879d01bf9fe8fc5e14388e173ccb3acf2ddc834cd68c07e281"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-08 06:06:03.645820) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 06:06:03.646656) ========= 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.Omo6nIVkg3/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.RYR72JuhNC/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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.004987 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 06:06:03.697379) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-08 06:06:03.697707) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-08 06:06:03.698057) ========= ========= Total master_lag: 0.39 =========