builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0193 starttime: 1493253771.76 results: success (0) buildid: 20170426153825 builduid: 67deccb195684117bff89b2f7dd13e98 revision: 745f2d85212d7c4bc82240c5a43730d9ecd32125 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-26 17:42:51.760397) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-26 17:42:51.760839) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-26 17:42:51.761157) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-26 17:42:51.788827) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 17:42:51.789175) ========= 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.2k1eQLne1N/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.uIpFTzjhxZ/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 --2017-04-26 17:42:51-- 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% 13.1M=0.001s 2017-04-26 17:42:51 (13.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.145151 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 17:42:51.960779) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 17:42:51.961142) ========= 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.2k1eQLne1N/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.uIpFTzjhxZ/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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.029117 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 17:42:52.013425) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-26 17:42:52.013870) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 745f2d85212d7c4bc82240c5a43730d9ecd32125 --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 745f2d85212d7c4bc82240c5a43730d9ecd32125 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2k1eQLne1N/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.uIpFTzjhxZ/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 2017-04-26 17:42:52,117 truncating revision to first 12 chars 2017-04-26 17:42:52,117 Setting DEBUG logging. 2017-04-26 17:42:52,117 attempt 1/10 2017-04-26 17:42:52,117 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/745f2d85212d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-26 17:42:53,368 unpacking tar archive at: mozilla-central-745f2d85212d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.531450 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-26 17:42:53.572026) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-26 17:42:53.572641) ========= script_repo_revision: 745f2d85212d7c4bc82240c5a43730d9ecd32125 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-26 17:42:53.573375) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-26 17:42:53.573857) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-26 17:42:53.596211) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-04-26 17:42:53.596625) ========= /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.2k1eQLne1N/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.uIpFTzjhxZ/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 17:42:53 INFO - MultiFileLogger online at 20170426 17:42:53 in /builds/slave/test 17:42:53 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 17:42:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:42:53 INFO - {'append_to_log': False, 17:42:53 INFO - 'base_work_dir': '/builds/slave/test', 17:42:53 INFO - 'blob_upload_branch': 'Firefox', 17:42:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:42:53 INFO - 'branch': 'Firefox', 17:42:53 INFO - 'buildbot_json_path': 'buildprops.json', 17:42:53 INFO - 'config_files': ('talos/mac_config.py',), 17:42:53 INFO - 'default_actions': ('clobber', 17:42:53 INFO - 'read-buildbot-config', 17:42:53 INFO - 'download-and-extract', 17:42:53 INFO - 'populate-webroot', 17:42:53 INFO - 'create-virtualenv', 17:42:53 INFO - 'install', 17:42:53 INFO - 'run-tests'), 17:42:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:42:53 INFO - 'download_minidump_stackwalk': True, 17:42:53 INFO - 'download_symbols': 'ondemand', 17:42:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:42:53 INFO - 'tooltool.py': '/tools/tooltool.py', 17:42:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:42:53 INFO - '/tools/misc-python/virtualenv.py')}, 17:42:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:42:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:42:53 INFO - 'gecko_profile': False, 17:42:53 INFO - 'gecko_profile_interval': 0, 17:42:53 INFO - 'installer_path': 'installer.exe', 17:42:53 INFO - 'log_level': 'info', 17:42:53 INFO - 'log_name': 'talos', 17:42:53 INFO - 'log_to_console': True, 17:42:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:42:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:42:53 INFO - 'opt_config_files': (), 17:42:53 INFO - 'pip_index': False, 17:42:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:42:53 INFO - 'cmd': ('bash', 17:42:53 INFO - '-c', 17:42:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:42:53 INFO - 'enabled': True, 17:42:53 INFO - 'halt_on_failure': False, 17:42:53 INFO - 'name': 'check_screen_resolution'},), 17:42:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:42:53 INFO - 'cmd': ('bash', 17:42:53 INFO - '-c', 17:42:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:42:53 INFO - 'enabled': True, 17:42:53 INFO - 'halt_on_failure': False, 17:42:53 INFO - 'name': 'check_screen_resolution'},), 17:42:53 INFO - 'run_cmd_checks_enabled': True, 17:42:53 INFO - 'suite': 'dromaeojs', 17:42:53 INFO - 'system_bits': '32', 17:42:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:42:53 INFO - 'title': 't-yosemite-r7-0193', 17:42:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:42:53 INFO - 'use_talos_json': True, 17:42:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:42:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:42:53 INFO - 'work_dir': 'build'} 17:42:53 INFO - [mozharness: 2017-04-27 00:42:53.816175Z] Running clobber step. 17:42:53 INFO - Running pre-action listener: _resource_record_pre_action 17:42:53 INFO - Running main action method: clobber 17:42:53 INFO - rmtree: /builds/slave/test/build 17:42:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:42:58 INFO - Running post-action listener: _resource_record_post_action 17:42:58 INFO - [mozharness: 2017-04-27 00:42:58.361242Z] Finished clobber step (success) 17:42:58 INFO - [mozharness: 2017-04-27 00:42:58.361475Z] Running read-buildbot-config step. 17:42:58 INFO - Running pre-action listener: _resource_record_pre_action 17:42:58 INFO - Running main action method: read_buildbot_config 17:42:58 INFO - Using buildbot properties: 17:42:58 INFO - { 17:42:58 INFO - "project": "", 17:42:58 INFO - "product": "firefox", 17:42:58 INFO - "script_repo_revision": "production", 17:42:58 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 17:42:58 INFO - "repository": "", 17:42:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 17:42:58 INFO - "buildid": "20170426153825", 17:42:58 INFO - "pgo_build": "False", 17:42:58 INFO - "basedir": "/builds/slave/test", 17:42:58 INFO - "buildnumber": 46, 17:42:58 INFO - "slavename": "t-yosemite-r7-0193", 17:42:58 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 17:42:58 INFO - "platform": "yosemite_r7", 17:42:58 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:42:58 INFO - "branch": "mozilla-central", 17:42:58 INFO - "repo_path": "mozilla-central", 17:42:58 INFO - "revision": "745f2d85212d7c4bc82240c5a43730d9ecd32125", 17:42:58 INFO - "stage_platform": "macosx64", 17:42:58 INFO - "builduid": "67deccb195684117bff89b2f7dd13e98", 17:42:58 INFO - "slavebuilddir": "test" 17:42:58 INFO - } 17:42:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 17:42:58 INFO - Running post-action listener: _resource_record_post_action 17:42:58 INFO - [mozharness: 2017-04-27 00:42:58.365705Z] Finished read-buildbot-config step (success) 17:42:58 INFO - [mozharness: 2017-04-27 00:42:58.365844Z] Running download-and-extract step. 17:42:58 INFO - Running pre-action listener: _resource_record_pre_action 17:42:58 INFO - Running main action method: download_and_extract 17:42:58 INFO - mkdir: /builds/slave/test/build/tests 17:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:58 INFO - trying https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 17:42:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:42:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 17:42:59 INFO - Downloaded 1325 bytes. 17:42:59 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:42:59 INFO - Using the following test package requirements: 17:42:59 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:42:59 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 17:42:59 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:42:59 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:42:59 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 17:42:59 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:42:59 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 17:42:59 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:42:59 INFO - u'jsshell-mac.zip'], 17:42:59 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:42:59 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 17:42:59 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:42:59 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:42:59 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 17:42:59 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:42:59 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 17:42:59 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:42:59 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 17:42:59 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:42:59 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 17:42:59 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:42:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 17:42:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:42:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:43:00 INFO - Content-Length response header: 52527127 17:43:00 INFO - Bytes received: 52527127 17:43:17 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:43:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 17:43:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:43:17 INFO - Fetch https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:43:19 INFO - Content-Length response header: 52527127 17:43:19 INFO - Bytes received: 52527127 17:43:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 17:43:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:43:34 INFO - Fetch https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 17:43:35 INFO - Content-Length response header: 14408809 17:43:35 INFO - Bytes received: 14408809 17:43: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')]} 17:43:36 INFO - trying https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:43:36 INFO - Downloading https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 17:43:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 17:43:38 INFO - Downloaded 71193027 bytes. 17:43:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:43:38 INFO - mkdir: /builds/slave/test/properties 17:43:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:43:38 INFO - Writing to file /builds/slave/test/properties/build_url 17:43:38 INFO - Contents: 17:43:38 INFO - build_url:https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:43:39 INFO - Running post-action listener: _resource_record_post_action 17:43:39 INFO - Running post-action listener: set_extra_try_arguments 17:43:39 INFO - [mozharness: 2017-04-27 00:43:39.726705Z] Finished download-and-extract step (success) 17:43:39 INFO - [mozharness: 2017-04-27 00:43:39.726848Z] Running populate-webroot step. 17:43:39 INFO - Running pre-action listener: _resource_record_pre_action 17:43:39 INFO - Running main action method: populate_webroot 17:43:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:43:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:43:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:43:39 INFO - '--tppagecycles', 17:43:39 INFO - '7'], 17:43:39 INFO - 'tests': ['tsvgm']}}, 17:43:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:43:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:43:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:43:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:43:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:43:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:43:39 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:43:39 INFO - 'talos_options': ['--disable-e10s'], 17:43:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:43:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:43:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:43:39 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:43:39 INFO - 'talos_options': ['--disable-e10s'], 17:43:39 INFO - 'tests': ['damp', 'tps']}, 17:43:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:43:39 INFO - 'tests': ['damp', 'tps']}, 17:43:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:43:39 INFO - 'tests': ['dromaeo_dom']}, 17:43:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:43:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:43:39 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:43:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:43:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:43:39 INFO - 'tests': ['a11yr', 17:43:39 INFO - 'ts_paint', 17:43:39 INFO - 'tpaint', 17:43:39 INFO - 'sessionrestore', 17:43:39 INFO - 'sessionrestore_no_auto_restore', 17:43:39 INFO - 'tabpaint']}, 17:43:39 INFO - 'other-e10s': {'tests': ['a11yr', 17:43:39 INFO - 'ts_paint', 17:43:39 INFO - 'tpaint', 17:43:39 INFO - 'sessionrestore', 17:43:39 INFO - 'sessionrestore_no_auto_restore', 17:43:39 INFO - 'tabpaint']}, 17:43:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:43:39 INFO - 'ts_paint', 17:43:39 INFO - 'tpaint', 17:43:39 INFO - 'sessionrestore', 17:43:39 INFO - 'sessionrestore_no_auto_restore', 17:43:39 INFO - 'tabpaint']}, 17:43:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:43:39 INFO - 'ts_paint', 17:43:39 INFO - 'tpaint', 17:43:39 INFO - 'sessionrestore', 17:43:39 INFO - 'sessionrestore_no_auto_restore', 17:43:39 INFO - 'tabpaint']}, 17:43:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:43:39 INFO - 'tests': ['a11yr', 17:43:39 INFO - 'ts_paint', 17:43:39 INFO - 'tpaint', 17:43:39 INFO - 'sessionrestore', 17:43:39 INFO - 'sessionrestore_no_auto_restore', 17:43:39 INFO - 'tabpaint']}, 17:43:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:43:39 INFO - 'tests': ['a11yr', 17:43:39 INFO - 'ts_paint', 17:43:39 INFO - 'tpaint', 17:43:39 INFO - 'sessionrestore', 17:43:39 INFO - 'sessionrestore_no_auto_restore', 17:43:39 INFO - 'tabpaint']}, 17:43:39 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 17:43:39 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 17:43:39 INFO - 'bloom_basic_ref']}, 17:43:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:43:39 INFO - 'tests': ['tsvgx', 17:43:39 INFO - 'tsvgr_opacity', 17:43:39 INFO - 'tart', 17:43:39 INFO - 'tscrollx', 17:43:39 INFO - 'cart', 17:43:39 INFO - 'tsvg_static']}, 17:43:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:43:39 INFO - 'tsvgr_opacity', 17:43:39 INFO - 'tart', 17:43:39 INFO - 'tscrollx', 17:43:39 INFO - 'cart', 17:43:39 INFO - 'tsvg_static']}, 17:43:39 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:43:39 INFO - 'talos_options': ['--disable-e10s'], 17:43:39 INFO - 'tests': ['tp5o']}, 17:43:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:43:39 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:43:39 INFO - 'talos_options': ['--disable-e10s', 17:43:39 INFO - '--xperf_path', 17:43:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:43:39 INFO - 'tests': ['tp5n']}, 17:43:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:43:39 INFO - 'talos_options': ['--xperf_path', 17:43:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:43:39 INFO - 'tests': ['tp5n']}}, 17:43:39 INFO - 'talos.zip': {'path': '', 17:43:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:43:39 INFO - Running post-action listener: _resource_record_post_action 17:43:39 INFO - [mozharness: 2017-04-27 00:43:39.746246Z] Finished populate-webroot step (success) 17:43:39 INFO - [mozharness: 2017-04-27 00:43:39.746358Z] Running create-virtualenv step. 17:43:39 INFO - Running pre-action listener: _resource_record_pre_action 17:43:39 INFO - Running main action method: create_virtualenv 17:43:39 INFO - Creating virtualenv /builds/slave/test/build/venv 17:43:39 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 17:43:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:43:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:43:39 INFO - Using real prefix '/tools/python27' 17:43:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:43:40 INFO - Installing distribute.............................................................................................................................................................................................done. 17:43:43 INFO - Installing pip.................done. 17:43:43 INFO - Return code: 0 17:43:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:43:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:43:43 INFO - Reading from file tmpfile_stdout 17:43:43 INFO - Output received: 17:43:43 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) 17:43:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:43 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 0x108bbbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bbe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd77955d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108999d30>, '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 0x1088bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10898ebe8>, '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.2k1eQLne1N/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.uIpFTzjhxZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 17:43:43 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 17:43:43 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 17:43:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2k1eQLne1N/Render', 17:43:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:43 INFO - 'HOME': '/Users/cltbld', 17:43:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:43 INFO - 'LOGNAME': 'cltbld', 17:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:43 INFO - 'MOZ_NO_REMOTE': '1', 17:43:43 INFO - 'NO_EM_RESTART': '1', 17:43:43 INFO - 'PAGER': '/bin/cat', 17:43:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:43 INFO - 'PWD': '/builds/slave/test', 17:43:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:43 INFO - 'SHELL': '/bin/bash', 17:43:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uIpFTzjhxZ/Listeners', 17:43:43 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 17:43:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:43 INFO - 'USER': 'cltbld', 17:43:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:43 INFO - 'XPC_FLAGS': '0x0', 17:43:43 INFO - 'XPC_SERVICE_NAME': '0', 17:43:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:44 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 17:43:44 INFO - Cleaning up... 17:43:44 INFO - Return code: 0 17:43:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:44 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 0x108bbbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bbe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd77955d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108999d30>, '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 0x1088bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10898ebe8>, '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.2k1eQLne1N/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.uIpFTzjhxZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 17:43:44 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 17:43:44 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 17:43:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2k1eQLne1N/Render', 17:43:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:44 INFO - 'HOME': '/Users/cltbld', 17:43:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:44 INFO - 'LOGNAME': 'cltbld', 17:43:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:44 INFO - 'MOZ_NO_REMOTE': '1', 17:43:44 INFO - 'NO_EM_RESTART': '1', 17:43:44 INFO - 'PAGER': '/bin/cat', 17:43:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:44 INFO - 'PWD': '/builds/slave/test', 17:43:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:44 INFO - 'SHELL': '/bin/bash', 17:43:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uIpFTzjhxZ/Listeners', 17:43:44 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 17:43:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:44 INFO - 'USER': 'cltbld', 17:43:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:44 INFO - 'XPC_FLAGS': '0x0', 17:43:44 INFO - 'XPC_SERVICE_NAME': '0', 17:43:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:44 INFO - Downloading/unpacking psutil>=3.1.1 17:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:43:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:43:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:43:47 INFO - Installing collected packages: psutil 17:43:47 INFO - Running setup.py install for psutil 17:43:47 INFO - building 'psutil._psutil_osx' extension 17:43:47 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 17:43:48 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 17:43:48 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 17:43:48 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 17:43:48 INFO - building 'psutil._psutil_posix' extension 17:43:48 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 17:43:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:43:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:43:48 INFO - ^ 17:43:48 INFO - 1 warning generated. 17:43:48 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 17:43:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:43:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:43:49 INFO - Successfully installed psutil 17:43:49 INFO - Cleaning up... 17:43:49 INFO - Return code: 0 17:43:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:43:49 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')]} 17:43:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:49 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')]} 17:43:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:49 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 0x108bbbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bbe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd77955d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108999d30>, '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 0x1088bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10898ebe8>, '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.2k1eQLne1N/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.uIpFTzjhxZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 17:43:49 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 17:43:49 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 17:43:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2k1eQLne1N/Render', 17:43:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:49 INFO - 'HOME': '/Users/cltbld', 17:43:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:49 INFO - 'LOGNAME': 'cltbld', 17:43:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:49 INFO - 'MOZ_NO_REMOTE': '1', 17:43:49 INFO - 'NO_EM_RESTART': '1', 17:43:49 INFO - 'PAGER': '/bin/cat', 17:43:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:49 INFO - 'PWD': '/builds/slave/test', 17:43:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:49 INFO - 'SHELL': '/bin/bash', 17:43:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uIpFTzjhxZ/Listeners', 17:43:49 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 17:43:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:49 INFO - 'USER': 'cltbld', 17:43:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:49 INFO - 'XPC_FLAGS': '0x0', 17:43:49 INFO - 'XPC_SERVICE_NAME': '0', 17:43:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:43:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:43:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:43:54 INFO - Installing collected packages: mozsystemmonitor 17:43:54 INFO - Running setup.py install for mozsystemmonitor 17:43:54 INFO - Successfully installed mozsystemmonitor 17:43:54 INFO - Cleaning up... 17:43:54 INFO - Return code: 0 17:43:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:43:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:54 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 0x108bbbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bbe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd77955d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108999d30>, '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 0x1088bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10898ebe8>, '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.2k1eQLne1N/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.uIpFTzjhxZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 17:43:54 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 17:43:54 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 17:43:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2k1eQLne1N/Render', 17:43:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:54 INFO - 'HOME': '/Users/cltbld', 17:43:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:54 INFO - 'LOGNAME': 'cltbld', 17:43:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:54 INFO - 'MOZ_NO_REMOTE': '1', 17:43:54 INFO - 'NO_EM_RESTART': '1', 17:43:54 INFO - 'PAGER': '/bin/cat', 17:43:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:54 INFO - 'PWD': '/builds/slave/test', 17:43:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:54 INFO - 'SHELL': '/bin/bash', 17:43:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uIpFTzjhxZ/Listeners', 17:43:54 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 17:43:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:54 INFO - 'USER': 'cltbld', 17:43:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:54 INFO - 'XPC_FLAGS': '0x0', 17:43:54 INFO - 'XPC_SERVICE_NAME': '0', 17:43:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:54 INFO - Downloading/unpacking jsonschema==2.5.1 17:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:43:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:43:57 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 17:43:57 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 17:43:57 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 17:43:57 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 17:43:57 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 17:43:57 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 17:43:57 INFO - Downloading functools32-3.2.3-2.tar.gz 17:43:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:43:58 INFO - warning: no files found matching '*.txt' 17:43:58 INFO - no previously-included directories found matching 'build' 17:43:58 INFO - no previously-included directories found matching 'dist' 17:43:58 INFO - no previously-included directories found matching '.git*' 17:43:58 INFO - Installing collected packages: jsonschema, functools32 17:43:58 INFO - Running setup.py install for functools32 17:43:58 INFO - warning: no files found matching '*.txt' 17:43:58 INFO - no previously-included directories found matching 'build' 17:43:58 INFO - no previously-included directories found matching 'dist' 17:43:58 INFO - no previously-included directories found matching '.git*' 17:43:58 INFO - Successfully installed jsonschema functools32 17:43:58 INFO - Cleaning up... 17:43:58 INFO - Return code: 0 17:43:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108bbbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bbe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd77955d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108999d30>, '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 0x1088bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10898ebe8>, '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.2k1eQLne1N/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.uIpFTzjhxZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 17:43:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:43:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:43:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2k1eQLne1N/Render', 17:43:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:58 INFO - 'HOME': '/Users/cltbld', 17:43:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:58 INFO - 'LOGNAME': 'cltbld', 17:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:58 INFO - 'MOZ_NO_REMOTE': '1', 17:43:58 INFO - 'NO_EM_RESTART': '1', 17:43:58 INFO - 'PAGER': '/bin/cat', 17:43:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:58 INFO - 'PWD': '/builds/slave/test', 17:43:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:58 INFO - 'SHELL': '/bin/bash', 17:43:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uIpFTzjhxZ/Listeners', 17:43:58 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 17:43:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:58 INFO - 'USER': 'cltbld', 17:43:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:58 INFO - 'XPC_FLAGS': '0x0', 17:43:58 INFO - 'XPC_SERVICE_NAME': '0', 17:43:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:43:58 INFO - Cleaning up... 17:43:58 INFO - Return code: 0 17:43:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108bbbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bbe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd77955d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108999d30>, '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 0x1088bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10898ebe8>, '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.2k1eQLne1N/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.uIpFTzjhxZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 17:43:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:43:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:43:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2k1eQLne1N/Render', 17:43:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:58 INFO - 'HOME': '/Users/cltbld', 17:43:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:58 INFO - 'LOGNAME': 'cltbld', 17:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:58 INFO - 'MOZ_NO_REMOTE': '1', 17:43:58 INFO - 'NO_EM_RESTART': '1', 17:43:58 INFO - 'PAGER': '/bin/cat', 17:43:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:58 INFO - 'PWD': '/builds/slave/test', 17:43:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:58 INFO - 'SHELL': '/bin/bash', 17:43:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uIpFTzjhxZ/Listeners', 17:43:58 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 17:43:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:58 INFO - 'USER': 'cltbld', 17:43:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:58 INFO - 'XPC_FLAGS': '0x0', 17:43:58 INFO - 'XPC_SERVICE_NAME': '0', 17:43:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:58 INFO - Downloading/unpacking blobuploader==1.2.4 17:43:58 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 17:43:58 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 17:43:58 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 17:43:58 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 17:43:58 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 17:43:58 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 17:44:01 INFO - Downloading blobuploader-1.2.4.tar.gz 17:44:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:44:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:44:01 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 17:44:01 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 17:44:01 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 17:44:01 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 17:44:01 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 17:44:01 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 17:44:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:44:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:44:02 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 17:44:02 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 17:44:02 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 17:44:02 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 17:44:02 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 17:44:02 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 17:44:02 INFO - Downloading docopt-0.6.1.tar.gz 17:44:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:44:02 INFO - Installing collected packages: blobuploader, requests, docopt 17:44:02 INFO - Running setup.py install for blobuploader 17:44:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:44:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:44:02 INFO - Running setup.py install for requests 17:44:03 INFO - Running setup.py install for docopt 17:44:03 INFO - Successfully installed blobuploader requests docopt 17:44:03 INFO - Cleaning up... 17:44:03 INFO - Return code: 0 17:44:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:03 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 0x108bbbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bbe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd77955d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108999d30>, '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 0x1088bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10898ebe8>, '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.2k1eQLne1N/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.uIpFTzjhxZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 17:44:03 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 17:44:03 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 17:44:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2k1eQLne1N/Render', 17:44:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:03 INFO - 'HOME': '/Users/cltbld', 17:44:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:03 INFO - 'LOGNAME': 'cltbld', 17:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:03 INFO - 'MOZ_NO_REMOTE': '1', 17:44:03 INFO - 'NO_EM_RESTART': '1', 17:44:03 INFO - 'PAGER': '/bin/cat', 17:44:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:03 INFO - 'PWD': '/builds/slave/test', 17:44:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:03 INFO - 'SHELL': '/bin/bash', 17:44:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uIpFTzjhxZ/Listeners', 17:44:03 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 17:44:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:03 INFO - 'USER': 'cltbld', 17:44:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:03 INFO - 'XPC_FLAGS': '0x0', 17:44:03 INFO - 'XPC_SERVICE_NAME': '0', 17:44:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:44:03 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-Ww2ACM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:44:04 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-3DJ7RU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:44:04 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-BrcVpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:44:04 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-DzoHhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:44:04 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-JeXoE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:44:04 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-u4SeTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:44:04 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-6LVU41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:44:04 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-f3cns6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:44:04 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-VwQpR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:44:04 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-cOFFl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:44:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:44:04 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-GE_p_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:44:05 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-FUHd4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:44:05 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-vmicEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:44:05 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-CdqTeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:05 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-773jP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:44:05 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-IVW4hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:44:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:44:05 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-pw7uoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:44:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:44:05 INFO - Running setup.py install for manifestparser 17:44:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:44:05 INFO - Running setup.py install for mozcrash 17:44:05 INFO - Running setup.py install for mozdebug 17:44:06 INFO - Running setup.py install for mozdevice 17:44:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:44:06 INFO - Running setup.py install for mozfile 17:44:06 INFO - Running setup.py install for mozhttpd 17:44:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:44:06 INFO - Running setup.py install for mozinfo 17:44:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:44:06 INFO - Running setup.py install for mozInstall 17:44:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:44:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:44:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:44:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:44:06 INFO - Running setup.py install for mozleak 17:44:06 INFO - Running setup.py install for mozlog 17:44:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:44:07 INFO - Running setup.py install for moznetwork 17:44:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:44:07 INFO - Running setup.py install for mozprocess 17:44:07 INFO - Running setup.py install for mozprofile 17:44:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:44:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:44:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:44:07 INFO - Running setup.py install for mozrunner 17:44:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:44:07 INFO - Running setup.py install for mozscreenshot 17:44:07 INFO - Running setup.py install for moztest 17:44:08 INFO - Running setup.py install for mozversion 17:44:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:44:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:44:08 INFO - Cleaning up... 17:44:08 INFO - Return code: 0 17:44:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:08 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 0x108bbbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bbe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd77955d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108999d30>, '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 0x1088bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10898ebe8>, '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.2k1eQLne1N/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.uIpFTzjhxZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 17:44:08 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 17:44:08 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 17:44:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2k1eQLne1N/Render', 17:44:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:08 INFO - 'HOME': '/Users/cltbld', 17:44:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:08 INFO - 'LOGNAME': 'cltbld', 17:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:08 INFO - 'MOZ_NO_REMOTE': '1', 17:44:08 INFO - 'NO_EM_RESTART': '1', 17:44:08 INFO - 'PAGER': '/bin/cat', 17:44:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:08 INFO - 'PWD': '/builds/slave/test', 17:44:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:08 INFO - 'SHELL': '/bin/bash', 17:44:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uIpFTzjhxZ/Listeners', 17:44:08 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 17:44:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:08 INFO - 'USER': 'cltbld', 17:44:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:08 INFO - 'XPC_FLAGS': '0x0', 17:44:08 INFO - 'XPC_SERVICE_NAME': '0', 17:44:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:44:08 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-UFHGMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:44:08 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)) 17:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:44:08 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-PbpL1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:44:08 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)) 17:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:44:08 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-7fyFPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:44:08 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)) 17:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:44:08 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-brxrRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:44:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 17:44:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:44:08 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-ci9JSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:44:09 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)) 17:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:44:09 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-uYe3Bn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:44:09 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)) 17:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:44:09 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-gcjKmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:44:09 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)) 17:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:44:09 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-2H1xb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:44:09 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)) 17:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:44:09 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-aKlwmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:44:09 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)) 17:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:44:09 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-rZwAvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:44:09 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)) 17:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:44:09 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-_4F82Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:44:09 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)) 17:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:44:09 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-lA0Fq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 17:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:44:09 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-87ISOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:44:09 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)) 17:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:44:09 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-JeeuIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:44:10 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)) 17:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:10 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-JopOSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:10 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)) 17:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:44:10 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-KOqXMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 17:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:44:10 INFO - Running setup.py (path:/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/pip-mvy5ZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:44:10 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)) 17:44:10 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)) 17:44:10 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)) 17:44:10 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)) 17:44:10 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:44:10 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:44:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:44:10 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 17:44:10 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 17:44:10 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 17:44:10 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 17:44:10 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 17:44:10 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 17:44:13 INFO - Downloading blessings-1.6.tar.gz 17:44:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:44:13 INFO - Installing collected packages: blessings 17:44:13 INFO - Running setup.py install for blessings 17:44:13 INFO - Successfully installed blessings 17:44:13 INFO - Cleaning up... 17:44:13 INFO - Return code: 0 17:44:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:44:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:44:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:44:13 INFO - Reading from file tmpfile_stdout 17:44:13 INFO - Current package versions: 17:44:13 INFO - blessings == 1.6 17:44:13 INFO - blobuploader == 1.2.4 17:44:13 INFO - docopt == 0.6.1 17:44:13 INFO - functools32 == 3.2.3-2 17:44:13 INFO - jsonschema == 2.5.1 17:44:13 INFO - manifestparser == 1.1 17:44:13 INFO - mozInstall == 1.12 17:44:13 INFO - mozcrash == 1.0 17:44:13 INFO - mozdebug == 0.1 17:44:13 INFO - mozdevice == 0.50 17:44:13 INFO - mozfile == 1.2 17:44:13 INFO - mozhttpd == 0.7 17:44:13 INFO - mozinfo == 0.9 17:44:13 INFO - mozleak == 0.1 17:44:13 INFO - mozlog == 3.4 17:44:13 INFO - moznetwork == 0.27 17:44:13 INFO - mozprocess == 0.25 17:44:13 INFO - mozprofile == 0.28 17:44:13 INFO - mozrunner == 6.13 17:44:13 INFO - mozscreenshot == 0.1 17:44:13 INFO - mozsystemmonitor == 0.3 17:44:13 INFO - moztest == 0.8 17:44:13 INFO - mozversion == 1.4 17:44:13 INFO - psutil == 3.1.1 17:44:13 INFO - requests == 1.2.3 17:44:13 INFO - wsgiref == 0.1.2 17:44:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44:13 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')]} 17:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:13 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')]} 17:44:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:13 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 0x108bbbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bbe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd77955d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108999d30>, '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 0x1088bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10898ebe8>, '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.2k1eQLne1N/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.uIpFTzjhxZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 17:44:13 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 17:44:13 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 17:44:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2k1eQLne1N/Render', 17:44:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:13 INFO - 'HOME': '/Users/cltbld', 17:44:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:13 INFO - 'LOGNAME': 'cltbld', 17:44:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:13 INFO - 'MOZ_NO_REMOTE': '1', 17:44:13 INFO - 'NO_EM_RESTART': '1', 17:44:13 INFO - 'PAGER': '/bin/cat', 17:44:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:13 INFO - 'PWD': '/builds/slave/test', 17:44:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:13 INFO - 'SHELL': '/bin/bash', 17:44:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uIpFTzjhxZ/Listeners', 17:44:13 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 17:44:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:13 INFO - 'USER': 'cltbld', 17:44:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:13 INFO - 'XPC_FLAGS': '0x0', 17:44:13 INFO - 'XPC_SERVICE_NAME': '0', 17:44:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:13 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)) 17:44:13 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)) 17:44:13 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)) 17:44:13 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)) 17:44:13 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)) 17:44:13 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)) 17:44:13 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)) 17:44:13 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)) 17:44:13 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)) 17:44:13 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)) 17:44:13 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)) 17:44:13 INFO - Cleaning up... 17:44:13 INFO - Return code: 0 17:44:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:44:13 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')]} 17:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:13 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')]} 17:44:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:13 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 0x108bbbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bbe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd77955d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108999d30>, '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 0x1088bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10898ebe8>, '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.2k1eQLne1N/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.uIpFTzjhxZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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 17:44:13 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 17:44:13 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 17:44:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2k1eQLne1N/Render', 17:44:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:13 INFO - 'HOME': '/Users/cltbld', 17:44:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:13 INFO - 'LOGNAME': 'cltbld', 17:44:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:13 INFO - 'MOZ_NO_REMOTE': '1', 17:44:13 INFO - 'NO_EM_RESTART': '1', 17:44:13 INFO - 'PAGER': '/bin/cat', 17:44:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:13 INFO - 'PWD': '/builds/slave/test', 17:44:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:13 INFO - 'SHELL': '/bin/bash', 17:44:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uIpFTzjhxZ/Listeners', 17:44:13 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 17:44:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:13 INFO - 'USER': 'cltbld', 17:44:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:13 INFO - 'XPC_FLAGS': '0x0', 17:44:13 INFO - 'XPC_SERVICE_NAME': '0', 17:44:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:44:14 INFO - Cleaning up... 17:44:14 INFO - Return code: 0 17:44:14 INFO - Running post-action listener: _resource_record_post_action 17:44:14 INFO - Running post-action listener: _start_resource_monitoring 17:44:14 INFO - Starting resource monitoring. 17:44:14 INFO - [mozharness: 2017-04-27 00:44:14.245445Z] Finished create-virtualenv step (success) 17:44:14 INFO - [mozharness: 2017-04-27 00:44:14.246445Z] Running install step. 17:44:14 INFO - Running pre-action listener: _resource_record_pre_action 17:44:14 INFO - Running main action method: install 17:44:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:44:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:44:14 INFO - Reading from file tmpfile_stdout 17:44:14 INFO - Detecting whether we're running mozinstall >=1.0... 17:44:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:44:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:44:14 INFO - Reading from file tmpfile_stdout 17:44:14 INFO - Output received: 17:44:14 INFO - Usage: mozinstall [options] installer 17:44:14 INFO - Options: 17:44:14 INFO - -h, --help show this help message and exit 17:44:14 INFO - -d DEST, --destination=DEST 17:44:14 INFO - Directory to install application into. [default: 17:44:14 INFO - "/builds/slave/test"] 17:44:14 INFO - --app=APP Application being installed. [default: firefox] 17:44:14 INFO - mkdir: /builds/slave/test/build/application 17:44:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:44:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:44:34 INFO - Reading from file tmpfile_stdout 17:44:34 INFO - Output received: 17:44:34 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:44:34 INFO - Running post-action listener: _resource_record_post_action 17:44:34 INFO - [mozharness: 2017-04-27 00:44:34.376759Z] Finished install step (success) 17:44:34 INFO - [mozharness: 2017-04-27 00:44:34.376909Z] Running run-tests step. 17:44:34 INFO - Running pre-action listener: _resource_record_pre_action 17:44:34 INFO - Running main action method: run_tests 17:44:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:44:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:44:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:44:34 INFO - 2017-04-26 17:44:34.391 screenresolution[1616:7367] starting screenresolution argv=screenresolution get 17:44:34 INFO - 2017-04-26 17:44:34.394 screenresolution[1616:7367] Display 0: 1600x1200x32@60 17:44:34 INFO - 2017-04-26 17:44:34.400 screenresolution[1617:7370] starting screenresolution argv=screenresolution list 17:44:34 INFO - Available Modes on Display 0 17:44:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:44:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:44:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:44:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:44:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:44:34 INFO - Intel Iris: 17:44:34 INFO - Chipset Model: Intel Iris 17:44:34 INFO - Type: GPU 17:44:34 INFO - Bus: Built-In 17:44:34 INFO - VRAM (Dynamic, Max): 1536 MB 17:44:34 INFO - Vendor: Intel (0x8086) 17:44:34 INFO - Device ID: 0x0a2e 17:44:34 INFO - Revision ID: 0x0009 17:44:34 INFO - Displays: 17:44:34 INFO - Display: 17:44:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:44:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:44:34 INFO - Display Serial Number: 1600x1200 60 17:44:34 INFO - Main Display: Yes 17:44:34 INFO - Mirror: Off 17:44:34 INFO - Online: Yes 17:44:34 INFO - Rotation: Supported 17:44:34 INFO - Return code: 0 17:44:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:44:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:44:34 INFO - Python 2.7.3 17:44:34 INFO - Return code: 0 17:44:34 INFO - grabbing minidump binary from tooltool 17:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:34 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 0x108999d30>, '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 0x1088bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10898ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:44:34 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 17:44:34 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 17:44:34 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 17:44:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:44:34 INFO - Return code: 0 17:44:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:44:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:44:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:44:34 INFO - ENV: RUST_BACKTRACE is now 1 17:44:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:44:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:44:34 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0193', '--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 17:44:34 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0193 --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 17:44:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2k1eQLne1N/Render', 17:44:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:34 INFO - 'HOME': '/Users/cltbld', 17:44:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:34 INFO - 'LOGNAME': 'cltbld', 17:44:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:44:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:44:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:34 INFO - 'MOZ_NO_REMOTE': '1', 17:44:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:44:34 INFO - 'NO_EM_RESTART': '1', 17:44:34 INFO - 'PAGER': '/bin/cat', 17:44:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:34 INFO - 'PWD': '/builds/slave/test', 17:44:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:44:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:34 INFO - 'RUST_BACKTRACE': '1', 17:44:34 INFO - 'SHELL': '/bin/bash', 17:44:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uIpFTzjhxZ/Listeners', 17:44:34 INFO - 'TMPDIR': '/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/', 17:44:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:34 INFO - 'USER': 'cltbld', 17:44:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:34 INFO - 'XPC_FLAGS': '0x0', 17:44:34 INFO - 'XPC_SERVICE_NAME': '0', 17:44:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:34 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0193', '--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 17:44:34 INFO - mozversion application_buildid: 20170426153825 17:44:34 INFO - mozversion application_changeset: 745f2d85212d7c4bc82240c5a43730d9ecd32125 17:44:34 INFO - mozversion application_display_name: Nightly 17:44:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:44:34 INFO - mozversion application_name: Firefox 17:44:34 INFO - mozversion application_remotingname: firefox 17:44:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:44:34 INFO - mozversion application_vendor: Mozilla 17:44:34 INFO - mozversion application_version: 55.0a1 17:44:34 INFO - mozversion platform_buildid: 20170426153825 17:44:34 INFO - mozversion platform_changeset: 745f2d85212d7c4bc82240c5a43730d9ecd32125 17:44:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:44:34 INFO - mozversion platform_version: 55.0a1 17:44:34 INFO - using testdate: 1493253874 17:44:34 INFO - actual date: 1493253874 17:44:34 INFO - starting webserver on 'localhost:49240' 17:44:34 INFO - SUITE-START | Running 2 tests 17:44:34 INFO - TEST-START | dromaeo_css 17:44:34 INFO - operating with platform_type : mac_ 17:44:34 INFO - Initialising browser for dromaeo_css test... 17:44:35 INFO - TEST-INFO | started process 1627 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/tmp4zIpEp/profile http://localhost:49240/getInfo.html) 17:44:37 INFO - PID 1627 | __metrics Screen width/height:1600/1200 17:44:37 INFO - PID 1627 | colorDepth:24 17:44:37 INFO - PID 1627 | Browser inner width/height: 1024/689 17:44:37 INFO - PID 1627 | __metrics 17:44:37 INFO - PID 1627 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:44:37 INFO - PID 1627 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:44:38 INFO - TEST-INFO | 1627: exit 0 17:44:38 INFO - Browser initialized. 17:44:38 INFO - Running cycle 1/1 for dromaeo_css test... 17:44:38 INFO - TEST-INFO | started process 1629 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/tmp4zIpEp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:44:50 INFO - PID 1629 | RSS: Main: 242941952 17:44:50 INFO - PID 1629 | 17:47:55 INFO - PID 1629 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 17:47:57 INFO - PID 1629 | RSS: Main: 416428032 17:47:57 INFO - PID 1629 | 17:49:40 INFO - PID 1629 | ************************* 17:49:40 INFO - PID 1629 | A coding exception was thrown and uncaught in a Task. 17:49:40 INFO - PID 1629 | 17:49:40 ERROR - PID 1629 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:49:40 INFO - PID 1629 | Full stack: 17:49:40 INFO - PID 1629 | ************************* 17:49:40 INFO - PID 1629 | ************************* 17:49:40 INFO - PID 1629 | A coding exception was thrown and uncaught in a Task. 17:49:40 INFO - PID 1629 | 17:49:40 ERROR - PID 1629 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:49:40 INFO - PID 1629 | Full stack: 17:49:40 INFO - PID 1629 | ************************* 17:49:40 INFO - PID 1629 | ************************* 17:49:40 INFO - PID 1629 | A coding exception was thrown and uncaught in a Task. 17:49:40 INFO - PID 1629 | 17:49:40 ERROR - PID 1629 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:49:40 INFO - PID 1629 | Full stack: 17:49:40 INFO - PID 1629 | ************************* 17:49:40 INFO - PID 1629 | ************************* 17:49:40 INFO - PID 1629 | A coding exception was thrown and uncaught in a Task. 17:49:40 INFO - PID 1629 | 17:49:40 ERROR - PID 1629 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:49:40 INFO - PID 1629 | Full stack: 17:49:40 INFO - PID 1629 | ************************* 17:50:59 INFO - PID 1629 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 17:51:00 INFO - PID 1629 | RSS: Main: 368926720 17:51:00 INFO - PID 1629 | 17:54:02 INFO - PID 1629 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 17:54:03 INFO - PID 1629 | RSS: Main: 352694272 17:54:03 INFO - PID 1629 | 17:57:05 INFO - PID 1629 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 17:57:06 INFO - PID 1629 | RSS: Main: 322281472 17:57:06 INFO - PID 1629 | 18:00:09 INFO - PID 1629 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 18:00:10 INFO - PID 1629 | RSS: Main: 338112512 18:00:10 INFO - PID 1629 | 18:03:12 INFO - PID 1629 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 18:03:12 INFO - PID 1629 | RSS: Main: 370233344 18:03:12 INFO - PID 1629 | 18:03:12 INFO - PID 1629 | __start_tp_report 18:03:12 INFO - PID 1629 | _x_x_mozilla_page_load 18:03:12 INFO - PID 1629 | _x_x_mozilla_page_load_details 18:03:12 INFO - PID 1629 | |i|pagename|runs| 18:03:12 INFO - PID 1629 | |0;dojo.html;3426.931461370771;3482.564679415075;3492.720582353412;3517.5427194464714;3546.29074185163;5859.003969325215;6000.909986350208;6162.506999440046;6172.321044685086;6180.845478863031;6131.908021379683;6142.293636231823;6143.385661433855;6163.907541386883;6172.166757487737;5092.949070509303;5143.871403214931;5239.580833533328;5272.657277276984;5370.892582148354;5353.652012619187;5358.678479291236;5371.838844834661;5388.515033646971;5406.162044883049;5170.146925757245;5254.106801843695;5265.4997775211295;5318.760655770461;5339.759710813003;5313.229581710669;5347.812826551052;5350.571954243651;5373.220882971987;5400.486953739389;5261.1319132343115;5312.548433383167;5319.175527793198;5326.866828329284;5375.596830237748;5868.559858010666;5944.64332140073;6169.413905678954;6171.25944886612;6176.783812566584;6343.8731225375695;6354.364563543609;6355.872882542323;6368.426841584233;6370.9681451592905;6469.126667899867;6564.606123632598;6567.704453299613;6576.80269591913;6584.637844918528;6059.969700151559;6175.351588083232;6203.410675985774;6207.565470417027;6208.099825525273;5857.150713146655;6338.01760727088;6626.403623673892;6658.800235992928;6676.26561078281;6311.684415779193;6340.3342649022115;6403.96798016007;6406.231252249667;6414.583052101599;6448.290688024314;6484.416402523795;6496.512761542808;6505.349465053457;6523.608583485006;6166;6412.807615771534;6415.13395691585;6416.486681065504;6438.066480360415;6279.748810047547;6310.43206111443;6315.242170939425;6317.96841015792;6323.114763933053;5136;5140.7943682253035;5146.639735218499;5152.278680984665;5164.173732202829;4559.794809233593;4560.4071470708595;4568.383268258743;4676.134915040729;4689.460712018162;6066.272047354346;6109.8472538186015;6135.294441139326;6240.375962403723;6240.937590624036;6485.416312531895;6535.57518761279;6540.771073012422;6552.50856185788;6588.011798230208;6167.969160154171;6216.222972128484;6217.813465595949;6232.657203853741;6236.469900058455;5552.472515111058;5609.382967873612;5623.156526521055;5629.493345598916;5630.662160270397;5422.8915421691345;6503.577267477599;6710.563813352116;6727.596344219362;6730.899036514554;6504.869902601827;6508.349165083454;6519.4784417245555;6525.2169739631545;6526.804195874131;6393.264774550986;6482.546221764431;6486.027095935648;6500.349965003462;6511.706973186123;6330.430261276507;6339.144215530844;6353.047042943595;6361.332060133619;6367.140436041075;4700.6474514410875;6332.651704156131;6382.808515744535;6626.2379826318665;6629.535932484872;6279.780207692709;6330.303666596578;6414.775482858077;6419.6790160490855;6441.420272175526;4980.8754781130765;6209.223847019122;6215.223097112861;6307.590006649553;6326.367363263636;6269.5611307208055;6281.120643109877;6289.119523266655;6300.873982520232;6312.873742525216;6181.165542651865;6253.405926436982;6270.310265870842;6345.428911397997;6463.7737679181;5483.75323110453;6119.959572021022;6244.562880598314;6284.685765711788;6291.905621415591 18:03:12 INFO - PID 1629 | |1;ext.html;759.6429678051314;787.7518581646781;808.0626473290981;903.20969151992;1051.7212938571274;25402;30142.849285753568;37740.24519509612;37820.24359512808;37847.432288515694;39483.210335793265;39873.40189897147;39951;39961.60038399615;39976.40035399464;6147.631142131464;8646.610902509403;8811.206991370775;8813.911860881406;8834.293256539493;6199.194104766374;8467.957660211721;8708.912910870906;8713.477191368538;8751.168638979287;8766.298696104328;8804.20762131408;8809.075047120055;8819;8819.867701984474;8709.346798990102;8743.562821858945;8773;8778.517181555011;8801.075887031897;8656.744772008024;8710.695125670634;8721.694740684046;8727.781805454852;8737.956310218407;37432.43851342205;37584.87245382643;37594.812025939966;37643.870683879526;37691.434628480594;3624.7643903146213;3654.9817250913575;3656.1590834108038;3656.6708996190205;3657.2868290683327;30641.69358306411;30658.84670576655;30695.38609227803;30753;30800.537991930138;3080.1067690369764;3096.8451577421265;3129.4523458394688;3135.952960705591;3146.496560550301;283756;289315;289518;289780.6532902008;291235;47890.760546197045;47989;48026.759866201144;48076.7596162024;48199.27701084487;49445;49511;49549;49622;49622.75188624106;11623.6512904613;13863.653408664864;13957.860421395859;13973.79039314411;13987.650308742159;9841.606335746634;9875.802483950425;9892.55483503244;11441.31352118859;11451;10344;10415.68752937398;10423.791524169474;10436.530356133992;11907.523699052113;5167.3799144102195;5204.8178313758835;5207.229541955753;5214.7914083436235;5215.035218484592;857.9061696337095;1011.610529945976;1024.3751311699857;1033.6898930321024;1050.5535147562255;23450.64824027641;23774.88112559426;23793.643095353582;23811.642825357634;23874.7612523876;1100.2793170473353;1101.1026013798728;1141.697450175704;1142.5372724046774;1165.347405452949;9482.38364506305;11517.136214783925;12106.213096148722;12170.57402990891;12185.69535761613;302851;302901.4854925755;303490;303623;304177;51333.48666513287;51363.743181283855;51381.22928156081;51413.7429312851;51508;1519.688463864905;1538.3154496249063;1589.7615357696438;1590;1591.1407839766396;17431.47705568835;23501.17745878886;23562.76437235674;23576.410589735395;23628.763712363343;36400.453993190655;36476.905692829256;36503.45244821277;36521.269574607824;36542.8172859134;276152;276954;277556.61221693765;277896;278258;32946;32986.34027319488;32996;33035;33098;31687.20781980469;31877.8842740503;39917.800410997756;41597.96005099897;43224.783876080415;21944.45138871541;27756.44487110206;29781.808727650652;29818.21070873499;29982.850085749433;28636.284092897844;29478.852605736833;29571.556426653187;29621.25946851346;29791.55312670268;34826.82586587051;35057.8247108773;35060.824695876356;35083.29833403369;36565.634343656224;29861.70138298676;30751.2312192197;30780.846095770274;31025.534616980312;31230;22131.889340553193;23073.423164421023;23839.046438142974;24025.879870600536;24177 18:03:12 INFO - PID 1629 | |2;jquery.html;358.0852749148142;441.1750027448671;442.687905026956;449.6447806233076;466.05158502447506;17456.999999999985;20297.898510507446;21650.675239871394;22151;22366.32901012968;18689.90655046726;22191.223307184253;22560.88719556404;23290;23479.530409391846;6179.660118693459;6288.088227207052;6356.459700925427;6383.457406120462;6393;6054.091886217058;6333.9683301583655;6339.904901426482;6348.269948955883;6358.745650173987;6028.577999540034;6207.472364848971;6301.180846489973;6314;6336.081268216106;6238.625682459067;6259.937400626004;6282.87434251317;6297.590656607329;6309.716062777186;5506.697131657757;5538.9169162462595;5611.102223644198;5616.241807356037;5624.409437009137;26792.59811102835;26879.462410751676;27164.592531112048;27405.903763849423;28126.718732812613;1960.6078784243066;2210.834187435949;2288.553732022256;2294.7475777664445;2297.425643589103;18259.45221643353;18262.817371826244;18264.269429222815;18551.97964111973;18594.53513662156;2174.793394627508;2198.1866709317496;2226.3543572363997;2230.56503981722;2234.5530893821137;130175.69824301731;134843;161392.19303903406;163162;165989.17005415016;10345.844812327821;11546.94226528862;12212.801695694683;12811.807822882663;12818.359082045861;15300.005499642488;15310.311036003406;15311.234438278041;15322.310496027705;15325.540233793005;7088.319628427174;9019;9072.455652660861;9146.634134634673;9172.724818255463;8515.787105322293;8516.787080322918;8527.275181609633;8704.173103555153;8704.78238044054;7744.535327880345;7888.802779930547;7919.247671471201;7938.76183714478;7944.6027698614835;2218.711567496215;2222.533268013703;2224.9888750556142;2225.1321984426086;2371.5019845832567;868.5700578213824;903.6069309850236;952.79991201847;953.6900507335143;996.4668902137322;20051.799482005285;20743.481412964797;20747.792522074888;20749.481262968548;21007.474813129487;966.7631430299481;981.704150521305;1018.511114664965;1021.6219998600566;1025.620520407454;9989.650362237287;10601.946990265;10670.30643008202;10743.623973160902;10755.462226888625;519766;520837;536508;538945;539039;125997.37001314935;129152.99999999812;131161.34419327843;131206;131759;1144.730988217785;1151.5508951508918;1191.5174354386488;1193.6478738772082;1199.6281152842473;17627.82372176262;17781.288748450435;17791.555211119827;17862.065546134952;17963.820361796214;42186.62506999494;45842.541574583825;49313;52684.73657631687;54895.451045490634;73940.63029684818;74581.6270918642;75345;79159.60420198092;80283.59149225532;8597.871031934652;8764.693235736719;8813.637249561509;9091.31815113856;9112.95443522778;14072.94452916015;14150.50473233473;14301.28493575338;14552.927235363755;14638.926805365905;11735.823962640738;11959.222650527689;12037;12207.572734954234;12291.139620226855;11233.606823761129;11430.599929002445;11505.597304094317;11672.066234701373;11737.237079589799;12208.877911220774;12270.87729122733;12422;12553.246805191719;12685.492580296685;8807.691730789391;9007.774805629911;9105.226055785333;9262.72211833646;9306.534673266446;10365.792684146125;11612.76774464489;11733.882661173278;11809.043970270055;12192.57325993586 18:03:12 INFO - PID 1629 | |3;mootools.html;1454.8617881301277;1490.2027415332786;1502.8346881842995;1515.295387644745;1517.3551240722684;11272;11791.646250612484;11797.764044719122;11811.232269902472;11818.113641476892;11505;11597.6520704379;11920;11924.821127683092;11935.58225462109;2539.860307683077;2577.613357996306;2588.5728854738945;2592.196419110082;2596.454744503647;2480.6899137607797;2535.784458321036;2537.619357096432;2538.936526586841;2540.771330580247;2494.962575561368;2534.1257266243115;2549.375403026252;2557.271177714352;2562.0392352867675;2482;2511.1211076123395;2538.225841118458;2540.3776074861685;2542.1737935171145;2481.4292712676006;2497.8751062446986;2507.9373015674573;2513.7863281620903;2526.5831137862233;11756.294622322688;11847.348395838226;11849.822252666218;11861;11879.940600296943;6583.80248592543;6832.316768323178;6843.452523798084;6844.794656160323;6850.520463567552;3996.9400458993136;4295.634871035965;4372.300431930876;4392.38506609075;4399.318105693623;1208.329377195656;1250.593557093948;1302.7720148973892;1304.0610760252603;1306.1314226039672;14996.25018749069;15240.314185861664;15258.465953691568;16232.269547870255;16323.510294691177;5352.143657014937;5515.200295957144;5656.85857853557;5666.490015898589;5677.545796336283;11673.76652466946;11680.182387232811;11682.182247242612;11689.298642081503;11701.941490292495;5650.26546548946;5845.912311315334;6583.341665833378;6606.306337834458;6618.30507796684;6027.186329845415;6098.878022439615;6254.155688981929;6269.905951410732;6274.811755647338;4301.397804307399;4348.565143485626;4387.714798538085;4389.670774691847;4468.218061839165;1244.570623135017;1252.1673087396962;1257.8742125787348;1268.4292068568996;1272.7200015996466;793.4168386236112;798.876174193001;823.7693445835056;824.884516167737;850.6384786465727;5393.352797664305;5998.880022399528;6059.48494377974;6249.562530622813;6438.645874476949;594.2898236607213;600.2197143713155;606.7209083821491;612.595686846688;613.4325748682451;3809.219110082482;3879.8836034919;3887;3912.39357899526;3959.425883246913;12405.255684658949;14383.928080359532;14818.777718334233;15004.399824006918;15342.15618141013;12325.445354959049;14686.192259425834;15122.848771512365;15252.008619439923;15275;8076.596170191467;8199.467034642728;8300.294474969694;8323;8398.076211616595;6506.544541882023;6607.240167380621;6729.629870357177;6737.056812046219;6783.626900520519;12990.870091299344;13381.39783709716;13387.665308367368;13458.125221860548;13505.459781608626;13707.177569345871;13923.094998825043;13925;14057.156570605797;14059.507917222849;8279.58602069882;8348.457350272456;8364.832703346021;8386.07515897471;8468.915310846813;10498.265121441425;10734.19493537972;10738.355698658106;10757.46212689378;10775.407352595683;9020.639174433212;9214.354995150275;9229.723108306762;9350.345475816628;9394.154526092685;8925.776855578662;8942.195202431813;8960.865587016331;9065.274778017874;9154.954225228832;6578.80263592093;8143.67425303005;8232.50604963704;8238.794030149294;8263.545504997282;5998.280206375089;6021.187139736079;6088.147659327787;6195.783147589813;6212.627242365473;5735.483806457439;6088.634681919099;6136.140940268455;6150.969245153925;6178.104174894525 18:03:12 INFO - PID 1629 | |4;prototype.html;402.8912193707699;404.732876301641;405.61263992886796;409.0469206748275;412.70285394515946;5344.91982620261;5351.812686555972;5843.5617328700355;5879.706014699264;5914.319853216882;4605.0559635274685;5494.2582751328555;5695.857603559903;5768.913466298009;5787.768489260435;4474.798634061475;4476.448424398094;4478.977605111986;4479.977600112011;4485.708428952116;3693.113652723354;4481.574250446202;4483.663725220606;4485.484169320537;4489.832643512694;4328.415663885383;4425.269830477983;4450.866474005768;4454.510003899569;4472.686911916151;4093.5701751315983;4433;4435.911281774379;4438.156750217465;4456.866294011184;3759.3045286622064;3963.2667956428154;3968.3253846846105;3973.6688209449867;3995.840166393341;5326.414094449608;5483.835484935458;5570.2480165177585;5589.161625756128;5702.230198923134;4225.091605304874;4797.640176986705;4912.336834527328;4918.360613120271;4926.926096108561;4794.712317260975;4906.816466672332;6076.848078798022;6085;6089.725962331706;3766.344726967481;4040.1919616076902;4095.508538975342;4096.959030409717;4120.855770048034;4946.516045186429;5485.957668043059;6175.795719834634;6365.840853978688;6506.934930650727;3685.3734865073;3972.3842804365368;4028.8187031583648;4035.5762644922447;4063.2482990646827;4067.8576249831704;4186.937195942063;4212.115455754265;4230.365445183185;4232.174725928415;4305.870823875289;4710.3405523226775;4947.575687912897;4959;4969.925451118236;4869.415670119608;5931.970340148272;6090.116933044684;6132.742787728505;6179;1267.4359909840216;1430.0061457287293;1435.19629007756;1444.4222311075655;1447.2185020089034;915.8900931888082;939.1876027236527;946.8674385586023;948.7533241357158;951.4006176109007;5010.223415370623;5693.914591281134;5823.330317013513;5849.590528662953;5884.529237660977;5057.747112644353;6375.681215939185;6385.338702747021;6387.2335319761;6410.166678331881;5237.685738855681;5520.411732373989;5643.266375371258;5750;5827.621204621686;2464.3715852457867;2554.4124851283937;3196.849134311646;3320.8007519548905;3391.609964854024;5637.830865074055;6497.667978064485;6531.967340163269;6621;6667.633280169637;6544.5785059527325;6563.573367731177;6568.967155164193;6585.407313341726;6599.591149230592;6386.552941294065;6530.640814755234;6603.933960660428;6623.503237257225;6625.569337993015;6395.296517382991;6417.807465776034;6420.518461115528;6438.356164383524;6443.162388889415;6117.755289788537;6307.936920630735;6321.178246828067;6325.746970121144;6352.711919454442;6569.507286953402;6605.57063790852;6639.103720997604;6667.733290668513;6690.933090669031;4187.141635964559;4204.327307630764;4206.684498662551;4216.789160542022;4244.7877606118955;5060.84817455477;5587.547237718141;6389.837030669848;6436.388543088399;6450.483961282992;5599.720013999202;6059.72731227087;6203.844903877439;6208.820324138399;6226.346233645402;5168.767405466688;5982.670953097448;6152.692365381802;6199.845003874759;6230.252369715482;5518.668879867221;6074.3925607438905;6085.1785009023215;6091.786787462417;6103.267607887082;5955.464008239279;6199.132121503083;6199.411055949678;6202.534809889366;6211.937880621136;4955.058538877602;5525.696086715269;5573.972130139486;6081.118237855575;6105.511559075175 18:03:12 INFO - PID 1629 | |5;yui.html;601.2634522709678;851.7444766570031;857.399820125912;864.58067837099;880.7049638371145;13161.868381316184;17648;18292.45122646321;18880.81119188808;18901.905490472564;14237.288135593231;17295.39466118686;17813.109344532786;17826.910865445654;17833.286668533245;992.4442312305114;1006.6879267427084;1009.6567167163163;1009.9141572966307;1012.099231683802;677.8203775999364;698.2807708060706;999.2954966748425;1043.4261156364007;1044.107288268531;1078.6979645699178;1079.4440862955546;1079.578964203961;1080.4273734920466;1082.7726177502734;1075.3279200499687;1075.8547596074586;1076.978460430787;1077.7090185649909;1083.0360978728938;518.8728761453431;528.2657106621799;624;789.7630710786741;793.4802704228739;16441.83558164415;16916.323347066227;16934;16947.915260423742;16993.23530441133;16277.186140693037;16480.17599120039;16893.23980420872;17049.7442538362;17078.743818842726;12942.805857912139;13218.669533261746;13235.867641323559;13242.801357979639;13261.668458288523;3471.8090505022215;3572.982135089334;3626.437902125175;3628.256207477461;3628.6189950055127;112106;113200.43399782949;113849.4307528457;113853;114966.42516787446;11315.886841131483;13289.800652990212;13369.73260534784;13608.251546164858;13638.249896255802;17792.46622601324;19787;19801.10895009728;20185.59628807445;20322.796772032387;7637.885431718529;7827.608619568999;7831.412644051719;7837.882431763528;7843.9607801961765;3823.9808800956375;3849.4418309344987;3873.1091848874917;3879.437481565157;3889.669378102836;4234;4294.184105020036;4309.698321117492;4310.80601372939;4369.6722745794195;940.7271891151489;942.830290547708;945.7257395355269;946.5835032585641;968.2689569375077;578.5920925747338;586.1647152807233;594.872102497965;601.2424345324922;619.1672200889795;10898.618548350769;11679.474423650956;11921.940390297994;11930.701732456759;11940.387215643163;577.408156639448;578.6007654718316;578.7424596054715;599.0804115682406;611.7461253579803;5425.7829686812875;5550.197150439083;5557.972210139004;5589.245451863946;5644.689542075143;97413.02586974182;98278;98610;100085;100399;73321.20145582565;87634;95254;95702.5214873935;97555;81394;82146.76779848307;82853.58573207216;83690;85457;7609.619519024137;10357.171426285728;10972.286801357886;11160.386178759922;11313.490892909675;34012.82993585115;42248.36627450529;42299.7885010573;42334.941626459586;42716;67464.6626766863;71622.5259119375;71899.36831851366;73220.26779732348;76949.84575231264;12071.57749478764;15664.553798164841;15889.841101588836;16057.357705691642;16203.918980405022;17808.10959452048;18380.448586542425;18704.625907481503;18851;18854;16631.002139871645;16808.159592020107;17255.309787608356;17276.481705548853;17507.47477575675;16387.09870957061;16933.57666058309;17121.657566848844;17203.483895483154;17304.567385815455;15869;16151.515454536382;16810.495685129466;16828.74756878623;16834.07412592319;10844.40355780408;11808.645740627795;11934.164608477324;12158.635240942785;12279.2018518796;13026.739465210832;13151.210927344007;13169.407376668265;13244.980280117288;13337.466501339837 18:03:12 INFO - PID 1629 | __end_tp_report 18:03:12 INFO - PID 1629 | __start_cc_report 18:03:12 INFO - PID 1629 | _x_x_mozilla_cycle_collect,1727 18:03:12 INFO - PID 1629 | __end_cc_report 18:03:12 INFO - PID 1629 | __startTimestamp1493254992844__endTimestamp 18:03:12 INFO - PID 1629 | 18:03:12 INFO - PID 1629 | ------- Summary: start ------- 18:03:12 INFO - PID 1629 | Number of tests: 6 18:03:12 INFO - PID 1629 | 18:03:12 INFO - PID 1629 | [#0] dojo.html Cycles:165 Average:5958.49 Median:6236.47 stddev:688.99 (11.0%) stddev-sans-first:661.86 18:03:12 INFO - PID 1629 | Values: 3426.9 3482.6 3492.7 3517.5 3546.3 5859.0 6000.9 6162.5 6172.3 6180.8 6131.9 6142.3 6143.4 6163.9 6172.2 5092.9 5143.9 5239.6 5272.7 5370.9 5353.7 5358.7 5371.8 5388.5 5406.2 5170.1 5254.1 5265.5 5318.8 5339.8 5313.2 5347.8 5350.6 5373.2 5400.5 5261.1 5312.5 5319.2 5326.9 5375.6 5868.6 5944.6 6169.4 6171.3 6176.8 6343.9 6354.4 6355.9 6368.4 6371.0 6469.1 6564.6 6567.7 6576.8 6584.6 6060.0 6175.4 6203.4 6207.6 6208.1 5857.2 6338.0 6626.4 6658.8 6676.3 6311.7 6340.3 6404.0 6406.2 6414.6 6448.3 6484.4 6496.5 6505.3 6523.6 6166.0 6412.8 6415.1 6416.5 6438.1 6279.7 6310.4 6315.2 6318.0 6323.1 5136.0 5140.8 5146.6 5152.3 5164.2 4559.8 4560.4 4568.4 4676.1 4689.5 6066.3 6109.8 6135.3 6240.4 6240.9 6485.4 6535.6 6540.8 6552.5 6588.0 6168.0 6216.2 6217.8 6232.7 6236.5 5552.5 5609.4 5623.2 5629.5 5630.7 5422.9 6503.6 6710.6 6727.6 6730.9 6504.9 6508.3 6519.5 6525.2 6526.8 6393.3 6482.5 6486.0 6500.3 6511.7 6330.4 6339.1 6353.0 6361.3 6367.1 4700.6 6332.7 6382.8 6626.2 6629.5 6279.8 6330.3 6414.8 6419.7 6441.4 4980.9 6209.2 6215.2 6307.6 6326.4 6269.6 6281.1 6289.1 6300.9 6312.9 6181.2 6253.4 6270.3 6345.4 6463.8 5483.8 6120.0 6244.6 6284.7 6291.9 18:03:12 INFO - PID 1629 | 18:03:12 INFO - PID 1629 | [#1] ext.html Cycles:180 Average:43495.40 Median:32966.17 stddev:76050.43 (230.7%) stddev-sans-first:76196.08 18:03:12 INFO - PID 1629 | Values: 759.6 787.8 808.1 903.2 1051.7 25402.0 30142.8 37740.2 37820.2 37847.4 39483.2 39873.4 39951.0 39961.6 39976.4 6147.6 8646.6 8811.2 8813.9 8834.3 6199.2 8468.0 8708.9 8713.5 8751.2 8766.3 8804.2 8809.1 8819.0 8819.9 8709.3 8743.6 8773.0 8778.5 8801.1 8656.7 8710.7 8721.7 8727.8 8738.0 37432.4 37584.9 37594.8 37643.9 37691.4 3624.8 3655.0 3656.2 3656.7 3657.3 30641.7 30658.8 30695.4 30753.0 30800.5 3080.1 3096.8 3129.5 3136.0 3146.5 283756.0 289315.0 289518.0 289780.7 291235.0 47890.8 47989.0 48026.8 48076.8 48199.3 49445.0 49511.0 49549.0 49622.0 49622.8 11623.7 13863.7 13957.9 13973.8 13987.7 9841.6 9875.8 9892.6 11441.3 11451.0 10344.0 10415.7 10423.8 10436.5 11907.5 5167.4 5204.8 5207.2 5214.8 5215.0 857.9 1011.6 1024.4 1033.7 1050.6 23450.6 23774.9 23793.6 23811.6 23874.8 1100.3 1101.1 1141.7 1142.5 1165.3 9482.4 11517.1 12106.2 12170.6 12185.7 302851.0 302901.5 303490.0 303623.0 304177.0 51333.5 51363.7 51381.2 51413.7 51508.0 1519.7 1538.3 1589.8 1590.0 1591.1 17431.5 23501.2 23562.8 23576.4 23628.8 36400.5 36476.9 36503.5 36521.3 36542.8 276152.0 276954.0 277556.6 277896.0 278258.0 32946.0 32986.3 32996.0 33035.0 33098.0 31687.2 31877.9 39917.8 41598.0 43224.8 21944.5 27756.4 29781.8 29818.2 29982.9 28636.3 29478.9 29571.6 29621.3 29791.6 34826.8 35057.8 35060.8 35083.3 36565.6 29861.7 30751.2 30780.8 31025.5 31230.0 22131.9 23073.4 23839.0 24025.9 24177.0 18:03:12 INFO - PID 1629 | 18:03:12 INFO - PID 1629 | [#2] jquery.html Cycles:180 Average:34676.49 Median:12424.72 stddev:90251.68 (726.4%) stddev-sans-first:90468.07 18:03:12 INFO - PID 1629 | Values: 358.1 441.2 442.7 449.6 466.1 17457.0 20297.9 21650.7 22151.0 22366.3 18689.9 22191.2 22560.9 23290.0 23479.5 6179.7 6288.1 6356.5 6383.5 6393.0 6054.1 6334.0 6339.9 6348.3 6358.7 6028.6 6207.5 6301.2 6314.0 6336.1 6238.6 6259.9 6282.9 6297.6 6309.7 5506.7 5538.9 5611.1 5616.2 5624.4 26792.6 26879.5 27164.6 27405.9 28126.7 1960.6 2210.8 2288.6 2294.7 2297.4 18259.5 18262.8 18264.3 18552.0 18594.5 2174.8 2198.2 2226.4 2230.6 2234.6 130175.7 134843.0 161392.2 163162.0 165989.2 10345.8 11546.9 12212.8 12811.8 12818.4 15300.0 15310.3 15311.2 15322.3 15325.5 7088.3 9019.0 9072.5 9146.6 9172.7 8515.8 8516.8 8527.3 8704.2 8704.8 7744.5 7888.8 7919.2 7938.8 7944.6 2218.7 2222.5 2225.0 2225.1 2371.5 868.6 903.6 952.8 953.7 996.5 20051.8 20743.5 20747.8 20749.5 21007.5 966.8 981.7 1018.5 1021.6 1025.6 9989.7 10601.9 10670.3 10743.6 10755.5 519766.0 520837.0 536508.0 538945.0 539039.0 125997.4 129153.0 131161.3 131206.0 131759.0 1144.7 1151.6 1191.5 1193.6 1199.6 17627.8 17781.3 17791.6 17862.1 17963.8 42186.6 45842.5 49313.0 52684.7 54895.5 73940.6 74581.6 75345.0 79159.6 80283.6 8597.9 8764.7 8813.6 9091.3 9113.0 14072.9 14150.5 14301.3 14552.9 14638.9 11735.8 11959.2 12037.0 12207.6 12291.1 11233.6 11430.6 11505.6 11672.1 11737.2 12208.9 12270.9 12422.0 12553.2 12685.5 8807.7 9007.8 9105.2 9262.7 9306.5 10365.8 11612.8 11733.9 11809.0 12192.6 18:03:12 INFO - PID 1629 | 18:03:12 INFO - PID 1629 | [#3] mootools.html Cycles:180 Average:7017.88 Median:3844.55 stddev:4420.41 (115.0%) stddev-sans-first:4413.04 18:03:12 INFO - PID 1629 | Values: 1454.9 1490.2 1502.8 1515.3 1517.4 11272.0 11791.6 11797.8 11811.2 11818.1 11505.0 11597.7 11920.0 11924.8 11935.6 2539.9 2577.6 2588.6 2592.2 2596.5 2480.7 2535.8 2537.6 2538.9 2540.8 2495.0 2534.1 2549.4 2557.3 2562.0 2482.0 2511.1 2538.2 2540.4 2542.2 2481.4 2497.9 2507.9 2513.8 2526.6 11756.3 11847.3 11849.8 11861.0 11879.9 6583.8 6832.3 6843.5 6844.8 6850.5 3996.9 4295.6 4372.3 4392.4 4399.3 1208.3 1250.6 1302.8 1304.1 1306.1 14996.3 15240.3 15258.5 16232.3 16323.5 5352.1 5515.2 5656.9 5666.5 5677.5 11673.8 11680.2 11682.2 11689.3 11701.9 5650.3 5845.9 6583.3 6606.3 6618.3 6027.2 6098.9 6254.2 6269.9 6274.8 4301.4 4348.6 4387.7 4389.7 4468.2 1244.6 1252.2 1257.9 1268.4 1272.7 793.4 798.9 823.8 824.9 850.6 5393.4 5998.9 6059.5 6249.6 6438.6 594.3 600.2 606.7 612.6 613.4 3809.2 3879.9 3887.0 3912.4 3959.4 12405.3 14383.9 14818.8 15004.4 15342.2 12325.4 14686.2 15122.8 15252.0 15275.0 8076.6 8199.5 8300.3 8323.0 8398.1 6506.5 6607.2 6729.6 6737.1 6783.6 12990.9 13381.4 13387.7 13458.1 13505.5 13707.2 13923.1 13925.0 14057.2 14059.5 8279.6 8348.5 8364.8 8386.1 8468.9 10498.3 10734.2 10738.4 10757.5 10775.4 9020.6 9214.4 9229.7 9350.3 9394.2 8925.8 8942.2 8960.9 9065.3 9155.0 6578.8 8143.7 8232.5 8238.8 8263.5 5998.3 6021.2 6088.1 6195.8 6212.6 5735.5 6088.6 6136.1 6151.0 6178.1 18:03:12 INFO - PID 1629 | 18:03:12 INFO - PID 1629 | [#4] prototype.html Cycles:180 Average:4977.39 Median:5572.11 stddev:1562.11 (28.0%) stddev-sans-first:1528.29 18:03:12 INFO - PID 1629 | Values: 402.9 404.7 405.6 409.0 412.7 5344.9 5351.8 5843.6 5879.7 5914.3 4605.1 5494.3 5695.9 5768.9 5787.8 4474.8 4476.4 4479.0 4480.0 4485.7 3693.1 4481.6 4483.7 4485.5 4489.8 4328.4 4425.3 4450.9 4454.5 4472.7 4093.6 4433.0 4435.9 4438.2 4456.9 3759.3 3963.3 3968.3 3973.7 3995.8 5326.4 5483.8 5570.2 5589.2 5702.2 4225.1 4797.6 4912.3 4918.4 4926.9 4794.7 4906.8 6076.8 6085.0 6089.7 3766.3 4040.2 4095.5 4097.0 4120.9 4946.5 5486.0 6175.8 6365.8 6506.9 3685.4 3972.4 4028.8 4035.6 4063.2 4067.9 4186.9 4212.1 4230.4 4232.2 4305.9 4710.3 4947.6 4959.0 4969.9 4869.4 5932.0 6090.1 6132.7 6179.0 1267.4 1430.0 1435.2 1444.4 1447.2 915.9 939.2 946.9 948.8 951.4 5010.2 5693.9 5823.3 5849.6 5884.5 5057.7 6375.7 6385.3 6387.2 6410.2 5237.7 5520.4 5643.3 5750.0 5827.6 2464.4 2554.4 3196.8 3320.8 3391.6 5637.8 6497.7 6532.0 6621.0 6667.6 6544.6 6563.6 6569.0 6585.4 6599.6 6386.6 6530.6 6603.9 6623.5 6625.6 6395.3 6417.8 6420.5 6438.4 6443.2 6117.8 6307.9 6321.2 6325.7 6352.7 6569.5 6605.6 6639.1 6667.7 6690.9 4187.1 4204.3 4206.7 4216.8 4244.8 5060.8 5587.5 6389.8 6436.4 6450.5 5599.7 6059.7 6203.8 6208.8 6226.3 5168.8 5982.7 6152.7 6199.8 6230.3 5518.7 6074.4 6085.2 6091.8 6103.3 5955.5 6199.1 6199.4 6202.5 6211.9 4955.1 5525.7 5574.0 6081.1 6105.5 18:03:12 INFO - PID 1629 | 18:03:12 INFO - PID 1629 | [#5] yui.html Cycles:180 Average:21563.18 Median:18062.87 stddev:29873.40 (165.4%) stddev-sans-first:29915.74 18:03:12 INFO - PID 1629 | Values: 601.3 851.7 857.4 864.6 880.7 13161.9 17648.0 18292.5 18880.8 18901.9 14237.3 17295.4 17813.1 17826.9 17833.3 992.4 1006.7 1009.7 1009.9 1012.1 677.8 698.3 999.3 1043.4 1044.1 1078.7 1079.4 1079.6 1080.4 1082.8 1075.3 1075.9 1077.0 1077.7 1083.0 518.9 528.3 624.0 789.8 793.5 16441.8 16916.3 16934.0 16947.9 16993.2 16277.2 16480.2 16893.2 17049.7 17078.7 12942.8 13218.7 13235.9 13242.8 13261.7 3471.8 3573.0 3626.4 3628.3 3628.6 112106.0 113200.4 113849.4 113853.0 114966.4 11315.9 13289.8 13369.7 13608.3 13638.2 17792.5 19787.0 19801.1 20185.6 20322.8 7637.9 7827.6 7831.4 7837.9 7844.0 3824.0 3849.4 3873.1 3879.4 3889.7 4234.0 4294.2 4309.7 4310.8 4369.7 940.7 942.8 945.7 946.6 968.3 578.6 586.2 594.9 601.2 619.2 10898.6 11679.5 11921.9 11930.7 11940.4 577.4 578.6 578.7 599.1 611.7 5425.8 5550.2 5558.0 5589.2 5644.7 97413.0 98278.0 98610.0 100085.0 100399.0 73321.2 87634.0 95254.0 95702.5 97555.0 81394.0 82146.8 82853.6 83690.0 85457.0 7609.6 10357.2 10972.3 11160.4 11313.5 34012.8 42248.4 42299.8 42334.9 42716.0 67464.7 71622.5 71899.4 73220.3 76949.8 12071.6 15664.6 15889.8 16057.4 16203.9 17808.1 18380.4 18704.6 18851.0 18854.0 16631.0 16808.2 17255.3 17276.5 17507.5 16387.1 16933.6 17121.7 17203.5 17304.6 15869.0 16151.5 16810.5 16828.7 16834.1 10844.4 11808.6 11934.2 12158.6 12279.2 13026.7 13151.2 13169.4 13245.0 13337.5 18:03:12 INFO - PID 1629 | -------- Summary: end -------- 18:03:12 INFO - PID 1629 | 18:03:13 INFO - TEST-INFO | 1629: exit 0 18:03:13 INFO - TEST-OK | dromaeo_css | took 1118518ms 18:03:13 INFO - TEST-START | kraken 18:03:13 INFO - operating with platform_type : mac_ 18:03:13 INFO - Initialising browser for kraken test... 18:03:13 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/tmpzaBEql/profile http://localhost:49240/getInfo.html) 18:03:16 INFO - PID 1638 | __metrics Screen width/height:1600/1200 18:03:16 INFO - PID 1638 | colorDepth:24 18:03:16 INFO - PID 1638 | Browser inner width/height: 1024/689 18:03:16 INFO - PID 1638 | __metrics 18:03:16 INFO - PID 1638 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:03:16 INFO - PID 1638 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:03:17 INFO - TEST-INFO | 1638: exit 0 18:03:17 INFO - Browser initialized. 18:03:17 INFO - Running cycle 1/1 for kraken test... 18:03:17 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zb/gjztv1j9199774r50d3phz4m00000w/T/tmpzaBEql/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:03:29 INFO - PID 1639 | RSS: Main: 242307072 18:03:29 INFO - PID 1639 | 18:03:31 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 18:03:32 INFO - PID 1639 | RSS: Main: 311595008 18:03:32 INFO - PID 1639 | 18:03:35 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 18:03:36 INFO - PID 1639 | RSS: Main: 292356096 18:03:36 INFO - PID 1639 | 18:03:39 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 18:03:40 INFO - PID 1639 | RSS: Main: 387203072 18:03:40 INFO - PID 1639 | 18:03:41 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 18:03:42 INFO - PID 1639 | RSS: Main: 289509376 18:03:42 INFO - PID 1639 | 18:03:44 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:03:45 INFO - PID 1639 | RSS: Main: 292225024 18:03:45 INFO - PID 1639 | 18:03:47 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 18:03:48 INFO - PID 1639 | RSS: Main: 356864000 18:03:48 INFO - PID 1639 | 18:03:51 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 18:03:52 INFO - PID 1639 | RSS: Main: 368676864 18:03:52 INFO - PID 1639 | 18:03:55 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 18:03:55 INFO - PID 1639 | RSS: Main: 373415936 18:03:55 INFO - PID 1639 | 18:03:57 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:03:57 INFO - PID 1639 | RSS: Main: 332906496 18:03:57 INFO - PID 1639 | 18:03:59 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:04:00 INFO - PID 1639 | RSS: Main: 335568896 18:04:00 INFO - PID 1639 | 18:04:02 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:04:02 INFO - PID 1639 | RSS: Main: 337600512 18:04:02 INFO - PID 1639 | 18:04:05 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:04:06 INFO - PID 1639 | RSS: Main: 352178176 18:04:06 INFO - PID 1639 | 18:04:09 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:04:10 INFO - PID 1639 | RSS: Main: 344211456 18:04:10 INFO - PID 1639 | 18:04:12 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 18:04:12 INFO - PID 1639 | RSS: Main: 387067904 18:04:12 INFO - PID 1639 | 18:04:12 INFO - PID 1639 | __start_tp_report 18:04:12 INFO - PID 1639 | _x_x_mozilla_page_load 18:04:12 INFO - PID 1639 | _x_x_mozilla_page_load_details 18:04:12 INFO - PID 1639 | |i|pagename|runs| 18:04:12 INFO - PID 1639 | |0;ai-astar;112;111;109;111;110;111;110;112;110;111 18:04:12 INFO - PID 1639 | |1;audio-beat-detection;140;107;106;146;105;109;107;108;137;109 18:04:12 INFO - PID 1639 | |2;audio-dft;187;184;186;254;215;184;184;187;184;185 18:04:12 INFO - PID 1639 | |3;audio-fft;80;57;59;87;59;57;57;59;81;57 18:04:12 INFO - PID 1639 | |4;audio-oscillator;90;69;85;70;68;67;87;69;68;89 18:04:12 INFO - PID 1639 | |5;imaging-gaussian-blur;88;87;87;87;87;87;88;87;88;87 18:04:12 INFO - PID 1639 | |6;imaging-darkroom;96;95;98;94;96;95;96;95;96;96 18:04:12 INFO - PID 1639 | |7;imaging-desaturate;100;129;84;85;83;83;83;86;85;84 18:04:12 INFO - PID 1639 | |8;json-parse-financial;49;49;49;47;50;50;51;49;48;49 18:04:12 INFO - PID 1639 | |9;json-stringify-tinderbox;54;61;64;68;62;59;58;58;58;58 18:04:12 INFO - PID 1639 | |10;stanford-crypto-aes;82;79;82;83;84;82;82;82;81;84 18:04:12 INFO - PID 1639 | |11;stanford-crypto-ccm;146;128;144;151;151;128;135;137;176;149 18:04:12 INFO - PID 1639 | |12;stanford-crypto-pbkdf2;187;182;185;185;192;182;187;181;183;185 18:04:12 INFO - PID 1639 | |13;stanford-crypto-sha256-iterative;67;68;66;69;68;67;68;69;67;68 18:04:12 INFO - PID 1639 | __end_tp_report 18:04:12 INFO - PID 1639 | __start_cc_report 18:04:12 INFO - PID 1639 | _x_x_mozilla_cycle_collect,2196 18:04:12 INFO - PID 1639 | __end_cc_report 18:04:12 INFO - PID 1639 | __startTimestamp1493255052341__endTimestamp 18:04:12 INFO - PID 1639 | 18:04:12 INFO - PID 1639 | ------- Summary: start ------- 18:04:12 INFO - PID 1639 | Number of tests: 14 18:04:12 INFO - PID 1639 | 18:04:12 INFO - PID 1639 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:0.95 (0.9%) stddev-sans-first:0.88 18:04:12 INFO - PID 1639 | Values: 112.0 111.0 109.0 111.0 110.0 111.0 110.0 112.0 110.0 111.0 18:04:12 INFO - PID 1639 | 18:04:12 INFO - PID 1639 | [#1] audio-beat-detection Cycles:10 Average:117.40 Median:109.00 stddev:16.47 (15.1%) stddev-sans-first:15.31 18:04:12 INFO - PID 1639 | Values: 140.0 107.0 106.0 146.0 105.0 109.0 107.0 108.0 137.0 109.0 18:04:12 INFO - PID 1639 | 18:04:12 INFO - PID 1639 | [#2] audio-dft Cycles:10 Average:195.00 Median:186.50 stddev:22.79 (12.2%) stddev-sans-first:23.99 18:04:12 INFO - PID 1639 | Values: 187.0 184.0 186.0 254.0 215.0 184.0 184.0 187.0 184.0 185.0 18:04:12 INFO - PID 1639 | 18:04:12 INFO - PID 1639 | [#3] audio-fft Cycles:10 Average:65.30 Median:59.00 stddev:12.15 (20.6%) stddev-sans-first:11.66 18:04:12 INFO - PID 1639 | Values: 80.0 57.0 59.0 87.0 59.0 57.0 57.0 59.0 81.0 57.0 18:04:12 INFO - PID 1639 | 18:04:12 INFO - PID 1639 | [#4] audio-oscillator Cycles:10 Average:76.20 Median:77.50 stddev:10.05 (13.0%) stddev-sans-first:9.34 18:04:12 INFO - PID 1639 | Values: 90.0 69.0 85.0 70.0 68.0 67.0 87.0 69.0 68.0 89.0 18:04:12 INFO - PID 1639 | 18:04:12 INFO - PID 1639 | [#5] imaging-gaussian-blur Cycles:10 Average:87.30 Median:87.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 18:04:12 INFO - PID 1639 | Values: 88.0 87.0 87.0 87.0 87.0 87.0 88.0 87.0 88.0 87.0 18:04:12 INFO - PID 1639 | 18:04:12 INFO - PID 1639 | [#6] imaging-darkroom Cycles:10 Average:95.70 Median:96.00 stddev:1.06 (1.1%) stddev-sans-first:1.12 18:04:12 INFO - PID 1639 | Values: 96.0 95.0 98.0 94.0 96.0 95.0 96.0 95.0 96.0 96.0 18:04:12 INFO - PID 1639 | 18:04:12 INFO - PID 1639 | [#7] imaging-desaturate Cycles:10 Average:90.20 Median:84.00 stddev:14.55 (17.3%) stddev-sans-first:15.00 18:04:12 INFO - PID 1639 | Values: 100.0 129.0 84.0 85.0 83.0 83.0 83.0 86.0 85.0 84.0 18:04:12 INFO - PID 1639 | 18:04:12 INFO - PID 1639 | [#8] json-parse-financial Cycles:10 Average:49.10 Median:49.00 stddev:1.10 (2.2%) stddev-sans-first:1.17 18:04:12 INFO - PID 1639 | Values: 49.0 49.0 49.0 47.0 50.0 50.0 51.0 49.0 48.0 49.0 18:04:12 INFO - PID 1639 | 18:04:12 INFO - PID 1639 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:3.92 (6.5%) stddev-sans-first:3.50 18:04:12 INFO - PID 1639 | Values: 54.0 61.0 64.0 68.0 62.0 59.0 58.0 58.0 58.0 58.0 18:04:12 INFO - PID 1639 | 18:04:12 INFO - PID 1639 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:82.00 stddev:1.45 (1.8%) stddev-sans-first:1.54 18:04:12 INFO - PID 1639 | Values: 82.0 79.0 82.0 83.0 84.0 82.0 82.0 82.0 81.0 84.0 18:04:12 INFO - PID 1639 | 18:04:12 INFO - PID 1639 | [#11] stanford-crypto-ccm Cycles:10 Average:144.50 Median:147.50 stddev:14.10 (9.6%) stddev-sans-first:14.95 18:04:12 INFO - PID 1639 | Values: 146.0 128.0 144.0 151.0 151.0 128.0 135.0 137.0 176.0 149.0 18:04:12 INFO - PID 1639 | 18:04:12 INFO - PID 1639 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.90 Median:185.00 stddev:3.25 (1.8%) stddev-sans-first:3.35 18:04:12 INFO - PID 1639 | Values: 187.0 182.0 185.0 185.0 192.0 182.0 187.0 181.0 183.0 185.0 18:04:12 INFO - PID 1639 | 18:04:12 INFO - PID 1639 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:0.95 (1.4%) stddev-sans-first:0.97 18:04:12 INFO - PID 1639 | Values: 67.0 68.0 66.0 69.0 68.0 67.0 68.0 69.0 67.0 68.0 18:04:12 INFO - PID 1639 | -------- Summary: end -------- 18:04:12 INFO - PID 1639 | 18:04:13 INFO - TEST-INFO | 1639: exit 0 18:04:13 INFO - TEST-OK | kraken | took 60043ms 18:04:13 INFO - SUITE-END | took 1178s 18:04:14 INFO - Completed test suite (00:19:39) 18:04:14 INFO - javascript benchmark 18:04:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7667.453804931198, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3426.931461370771, 3482.564679415075, 3492.720582353412, 3517.5427194464714, 3546.29074185163, 5859.003969325215, 6000.909986350208, 6162.506999440046, 6172.321044685086, 6180.845478863031, 6131.908021379683, 6142.293636231823, 6143.385661433855, 6163.907541386883, 6172.166757487737, 5092.949070509303, 5143.871403214931, 5239.580833533328, 5272.657277276984, 5370.892582148354, 5353.652012619187, 5358.678479291236, 5371.838844834661, 5388.515033646971, 5406.162044883049, 5170.146925757245, 5254.106801843695, 5265.4997775211295, 5318.760655770461, 5339.759710813003, 5313.229581710669, 5347.812826551052, 5350.571954243651, 5373.220882971987, 5400.486953739389, 5261.1319132343115, 5312.548433383167, 5319.175527793198, 5326.866828329284, 5375.596830237748, 5868.559858010666, 5944.64332140073, 6169.413905678954, 6171.25944886612, 6176.783812566584, 6343.8731225375695, 6354.364563543609, 6355.872882542323, 6368.426841584233, 6370.9681451592905, 6469.126667899867, 6564.606123632598, 6567.704453299613, 6576.80269591913, 6584.637844918528, 6059.969700151559, 6175.351588083232, 6203.410675985774, 6207.565470417027, 6208.099825525273, 5857.150713146655, 6338.01760727088, 6626.403623673892, 6658.800235992928, 6676.26561078281, 6311.684415779193, 6340.3342649022115, 6403.96798016007, 6406.231252249667, 6414.583052101599, 6448.290688024314, 6484.416402523795, 6496.512761542808, 6505.349465053457, 6523.608583485006, 6166.0, 6412.807615771534, 6415.13395691585, 6416.486681065504, 6438.066480360415, 6279.748810047547, 6310.43206111443, 6315.242170939425, 6317.96841015792, 6323.114763933053, 5136.0, 5140.7943682253035, 5146.639735218499, 5152.278680984665, 5164.173732202829, 4559.794809233593, 4560.4071470708595, 4568.383268258743, 4676.134915040729, 4689.460712018162, 6066.272047354346, 6109.8472538186015, 6135.294441139326, 6240.375962403723, 6240.937590624036, 6485.416312531895, 6535.57518761279, 6540.771073012422, 6552.50856185788, 6588.011798230208, 6167.969160154171, 6216.222972128484, 6217.813465595949, 6232.657203853741, 6236.469900058455, 5552.472515111058, 5609.382967873612, 5623.156526521055, 5629.493345598916, 5630.662160270397, 5422.8915421691345, 6503.577267477599, 6710.563813352116, 6727.596344219362, 6730.899036514554, 6504.869902601827, 6508.349165083454, 6519.4784417245555, 6525.2169739631545, 6526.804195874131, 6393.264774550986, 6482.546221764431, 6486.027095935648, 6500.349965003462, 6511.706973186123, 6330.430261276507, 6339.144215530844, 6353.047042943595, 6361.332060133619, 6367.140436041075, 4700.6474514410875, 6332.651704156131, 6382.808515744535, 6626.2379826318665, 6629.535932484872, 6279.780207692709, 6330.303666596578, 6414.775482858077, 6419.6790160490855, 6441.420272175526, 4980.8754781130765, 6209.223847019122, 6215.223097112861, 6307.590006649553, 6326.367363263636, 6269.5611307208055, 6281.120643109877, 6289.119523266655, 6300.873982520232, 6312.873742525216, 6181.165542651865, 6253.405926436982, 6270.310265870842, 6345.428911397997, 6463.7737679181, 5483.75323110453, 6119.959572021022, 6244.562880598314, 6284.685765711788, 6291.905621415591], "value": 5915.177353111897, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [759.6429678051314, 787.7518581646781, 808.0626473290981, 903.20969151992, 1051.7212938571274, 25402.0, 30142.849285753568, 37740.24519509612, 37820.24359512808, 37847.432288515694, 39483.210335793265, 39873.40189897147, 39951.0, 39961.60038399615, 39976.40035399464, 6147.631142131464, 8646.610902509403, 8811.206991370775, 8813.911860881406, 8834.293256539493, 6199.194104766374, 8467.957660211721, 8708.912910870906, 8713.477191368538, 8751.168638979287, 8766.298696104328, 8804.20762131408, 8809.075047120055, 8819.0, 8819.867701984474, 8709.346798990102, 8743.562821858945, 8773.0, 8778.517181555011, 8801.075887031897, 8656.744772008024, 8710.695125670634, 8721.694740684046, 8727.781805454852, 8737.956310218407, 37432.43851342205, 37584.87245382643, 37594.812025939966, 37643.870683879526, 37691.434628480594, 3624.7643903146213, 3654.9817250913575, 3656.1590834108038, 3656.6708996190205, 3657.2868290683327, 30641.69358306411, 30658.84670576655, 30695.38609227803, 30753.0, 30800.537991930138, 3080.1067690369764, 3096.8451577421265, 3129.4523458394688, 3135.952960705591, 3146.496560550301, 283756.0, 289315.0, 289518.0, 289780.6532902008, 291235.0, 47890.760546197045, 47989.0, 48026.759866201144, 48076.7596162024, 48199.27701084487, 49445.0, 49511.0, 49549.0, 49622.0, 49622.75188624106, 11623.6512904613, 13863.653408664864, 13957.860421395859, 13973.79039314411, 13987.650308742159, 9841.606335746634, 9875.802483950425, 9892.55483503244, 11441.31352118859, 11451.0, 10344.0, 10415.68752937398, 10423.791524169474, 10436.530356133992, 11907.523699052113, 5167.3799144102195, 5204.8178313758835, 5207.229541955753, 5214.7914083436235, 5215.035218484592, 857.9061696337095, 1011.610529945976, 1024.3751311699857, 1033.6898930321024, 1050.5535147562255, 23450.64824027641, 23774.88112559426, 23793.643095353582, 23811.642825357634, 23874.7612523876, 1100.2793170473353, 1101.1026013798728, 1141.697450175704, 1142.5372724046774, 1165.347405452949, 9482.38364506305, 11517.136214783925, 12106.213096148722, 12170.57402990891, 12185.69535761613, 302851.0, 302901.4854925755, 303490.0, 303623.0, 304177.0, 51333.48666513287, 51363.743181283855, 51381.22928156081, 51413.7429312851, 51508.0, 1519.688463864905, 1538.3154496249063, 1589.7615357696438, 1590.0, 1591.1407839766396, 17431.47705568835, 23501.17745878886, 23562.76437235674, 23576.410589735395, 23628.763712363343, 36400.453993190655, 36476.905692829256, 36503.45244821277, 36521.269574607824, 36542.8172859134, 276152.0, 276954.0, 277556.61221693765, 277896.0, 278258.0, 32946.0, 32986.34027319488, 32996.0, 33035.0, 33098.0, 31687.20781980469, 31877.8842740503, 39917.800410997756, 41597.96005099897, 43224.783876080415, 21944.45138871541, 27756.44487110206, 29781.808727650652, 29818.21070873499, 29982.850085749433, 28636.284092897844, 29478.852605736833, 29571.556426653187, 29621.25946851346, 29791.55312670268, 34826.82586587051, 35057.8247108773, 35060.824695876356, 35083.29833403369, 36565.634343656224, 29861.70138298676, 30751.2312192197, 30780.846095770274, 31025.534616980312, 31230.0, 22131.889340553193, 23073.423164421023, 23839.046438142974, 24025.879870600536, 24177.0], "value": 16914.811886980086, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.0852749148142, 441.1750027448671, 442.687905026956, 449.6447806233076, 466.05158502447506, 17456.999999999985, 20297.898510507446, 21650.675239871394, 22151.0, 22366.32901012968, 18689.90655046726, 22191.223307184253, 22560.88719556404, 23290.0, 23479.530409391846, 6179.660118693459, 6288.088227207052, 6356.459700925427, 6383.457406120462, 6393.0, 6054.091886217058, 6333.9683301583655, 6339.904901426482, 6348.269948955883, 6358.745650173987, 6028.577999540034, 6207.472364848971, 6301.180846489973, 6314.0, 6336.081268216106, 6238.625682459067, 6259.937400626004, 6282.87434251317, 6297.590656607329, 6309.716062777186, 5506.697131657757, 5538.9169162462595, 5611.102223644198, 5616.241807356037, 5624.409437009137, 26792.59811102835, 26879.462410751676, 27164.592531112048, 27405.903763849423, 28126.718732812613, 1960.6078784243066, 2210.834187435949, 2288.553732022256, 2294.7475777664445, 2297.425643589103, 18259.45221643353, 18262.817371826244, 18264.269429222815, 18551.97964111973, 18594.53513662156, 2174.793394627508, 2198.1866709317496, 2226.3543572363997, 2230.56503981722, 2234.5530893821137, 130175.69824301731, 134843.0, 161392.19303903406, 163162.0, 165989.17005415016, 10345.844812327821, 11546.94226528862, 12212.801695694683, 12811.807822882663, 12818.359082045861, 15300.005499642488, 15310.311036003406, 15311.234438278041, 15322.310496027705, 15325.540233793005, 7088.319628427174, 9019.0, 9072.455652660861, 9146.634134634673, 9172.724818255463, 8515.787105322293, 8516.787080322918, 8527.275181609633, 8704.173103555153, 8704.78238044054, 7744.535327880345, 7888.802779930547, 7919.247671471201, 7938.76183714478, 7944.6027698614835, 2218.711567496215, 2222.533268013703, 2224.9888750556142, 2225.1321984426086, 2371.5019845832567, 868.5700578213824, 903.6069309850236, 952.79991201847, 953.6900507335143, 996.4668902137322, 20051.799482005285, 20743.481412964797, 20747.792522074888, 20749.481262968548, 21007.474813129487, 966.7631430299481, 981.704150521305, 1018.511114664965, 1021.6219998600566, 1025.620520407454, 9989.650362237287, 10601.946990265, 10670.30643008202, 10743.623973160902, 10755.462226888625, 519766.0, 520837.0, 536508.0, 538945.0, 539039.0, 125997.37001314935, 129152.99999999812, 131161.34419327843, 131206.0, 131759.0, 1144.730988217785, 1151.5508951508918, 1191.5174354386488, 1193.6478738772082, 1199.6281152842473, 17627.82372176262, 17781.288748450435, 17791.555211119827, 17862.065546134952, 17963.820361796214, 42186.62506999494, 45842.541574583825, 49313.0, 52684.73657631687, 54895.451045490634, 73940.63029684818, 74581.6270918642, 75345.0, 79159.60420198092, 80283.59149225532, 8597.871031934652, 8764.693235736719, 8813.637249561509, 9091.31815113856, 9112.95443522778, 14072.94452916015, 14150.50473233473, 14301.28493575338, 14552.927235363755, 14638.926805365905, 11735.823962640738, 11959.222650527689, 12037.0, 12207.572734954234, 12291.139620226855, 11233.606823761129, 11430.599929002445, 11505.597304094317, 11672.066234701373, 11737.237079589799, 12208.877911220774, 12270.87729122733, 12422.0, 12553.246805191719, 12685.492580296685, 8807.691730789391, 9007.774805629911, 9105.226055785333, 9262.72211833646, 9306.534673266446, 10365.792684146125, 11612.76774464489, 11733.882661173278, 11809.043970270055, 12192.57325993586], "value": 10390.594581781905, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1454.8617881301277, 1490.2027415332786, 1502.8346881842995, 1515.295387644745, 1517.3551240722684, 11272.0, 11791.646250612484, 11797.764044719122, 11811.232269902472, 11818.113641476892, 11505.0, 11597.6520704379, 11920.0, 11924.821127683092, 11935.58225462109, 2539.860307683077, 2577.613357996306, 2588.5728854738945, 2592.196419110082, 2596.454744503647, 2480.6899137607797, 2535.784458321036, 2537.619357096432, 2538.936526586841, 2540.771330580247, 2494.962575561368, 2534.1257266243115, 2549.375403026252, 2557.271177714352, 2562.0392352867675, 2482.0, 2511.1211076123395, 2538.225841118458, 2540.3776074861685, 2542.1737935171145, 2481.4292712676006, 2497.8751062446986, 2507.9373015674573, 2513.7863281620903, 2526.5831137862233, 11756.294622322688, 11847.348395838226, 11849.822252666218, 11861.0, 11879.940600296943, 6583.80248592543, 6832.316768323178, 6843.452523798084, 6844.794656160323, 6850.520463567552, 3996.9400458993136, 4295.634871035965, 4372.300431930876, 4392.38506609075, 4399.318105693623, 1208.329377195656, 1250.593557093948, 1302.7720148973892, 1304.0610760252603, 1306.1314226039672, 14996.25018749069, 15240.314185861664, 15258.465953691568, 16232.269547870255, 16323.510294691177, 5352.143657014937, 5515.200295957144, 5656.85857853557, 5666.490015898589, 5677.545796336283, 11673.76652466946, 11680.182387232811, 11682.182247242612, 11689.298642081503, 11701.941490292495, 5650.26546548946, 5845.912311315334, 6583.341665833378, 6606.306337834458, 6618.30507796684, 6027.186329845415, 6098.878022439615, 6254.155688981929, 6269.905951410732, 6274.811755647338, 4301.397804307399, 4348.565143485626, 4387.714798538085, 4389.670774691847, 4468.218061839165, 1244.570623135017, 1252.1673087396962, 1257.8742125787348, 1268.4292068568996, 1272.7200015996466, 793.4168386236112, 798.876174193001, 823.7693445835056, 824.884516167737, 850.6384786465727, 5393.352797664305, 5998.880022399528, 6059.48494377974, 6249.562530622813, 6438.645874476949, 594.2898236607213, 600.2197143713155, 606.7209083821491, 612.595686846688, 613.4325748682451, 3809.219110082482, 3879.8836034919, 3887.0, 3912.39357899526, 3959.425883246913, 12405.255684658949, 14383.928080359532, 14818.777718334233, 15004.399824006918, 15342.15618141013, 12325.445354959049, 14686.192259425834, 15122.848771512365, 15252.008619439923, 15275.0, 8076.596170191467, 8199.467034642728, 8300.294474969694, 8323.0, 8398.076211616595, 6506.544541882023, 6607.240167380621, 6729.629870357177, 6737.056812046219, 6783.626900520519, 12990.870091299344, 13381.39783709716, 13387.665308367368, 13458.125221860548, 13505.459781608626, 13707.177569345871, 13923.094998825043, 13925.0, 14057.156570605797, 14059.507917222849, 8279.58602069882, 8348.457350272456, 8364.832703346021, 8386.07515897471, 8468.915310846813, 10498.265121441425, 10734.19493537972, 10738.355698658106, 10757.46212689378, 10775.407352595683, 9020.639174433212, 9214.354995150275, 9229.723108306762, 9350.345475816628, 9394.154526092685, 8925.776855578662, 8942.195202431813, 8960.865587016331, 9065.274778017874, 9154.954225228832, 6578.80263592093, 8143.67425303005, 8232.50604963704, 8238.794030149294, 8263.545504997282, 5998.280206375089, 6021.187139736079, 6088.147659327787, 6195.783147589813, 6212.627242365473, 5735.483806457439, 6088.634681919099, 6136.140940268455, 6150.969245153925, 6178.104174894525], "value": 5291.480439867078, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.8912193707699, 404.732876301641, 405.61263992886796, 409.0469206748275, 412.70285394515946, 5344.91982620261, 5351.812686555972, 5843.5617328700355, 5879.706014699264, 5914.319853216882, 4605.0559635274685, 5494.2582751328555, 5695.857603559903, 5768.913466298009, 5787.768489260435, 4474.798634061475, 4476.448424398094, 4478.977605111986, 4479.977600112011, 4485.708428952116, 3693.113652723354, 4481.574250446202, 4483.663725220606, 4485.484169320537, 4489.832643512694, 4328.415663885383, 4425.269830477983, 4450.866474005768, 4454.510003899569, 4472.686911916151, 4093.5701751315983, 4433.0, 4435.911281774379, 4438.156750217465, 4456.866294011184, 3759.3045286622064, 3963.2667956428154, 3968.3253846846105, 3973.6688209449867, 3995.840166393341, 5326.414094449608, 5483.835484935458, 5570.2480165177585, 5589.161625756128, 5702.230198923134, 4225.091605304874, 4797.640176986705, 4912.336834527328, 4918.360613120271, 4926.926096108561, 4794.712317260975, 4906.816466672332, 6076.848078798022, 6085.0, 6089.725962331706, 3766.344726967481, 4040.1919616076902, 4095.508538975342, 4096.959030409717, 4120.855770048034, 4946.516045186429, 5485.957668043059, 6175.795719834634, 6365.840853978688, 6506.934930650727, 3685.3734865073, 3972.3842804365368, 4028.8187031583648, 4035.5762644922447, 4063.2482990646827, 4067.8576249831704, 4186.937195942063, 4212.115455754265, 4230.365445183185, 4232.174725928415, 4305.870823875289, 4710.3405523226775, 4947.575687912897, 4959.0, 4969.925451118236, 4869.415670119608, 5931.970340148272, 6090.116933044684, 6132.742787728505, 6179.0, 1267.4359909840216, 1430.0061457287293, 1435.19629007756, 1444.4222311075655, 1447.2185020089034, 915.8900931888082, 939.1876027236527, 946.8674385586023, 948.7533241357158, 951.4006176109007, 5010.223415370623, 5693.914591281134, 5823.330317013513, 5849.590528662953, 5884.529237660977, 5057.747112644353, 6375.681215939185, 6385.338702747021, 6387.2335319761, 6410.166678331881, 5237.685738855681, 5520.411732373989, 5643.266375371258, 5750.0, 5827.621204621686, 2464.3715852457867, 2554.4124851283937, 3196.849134311646, 3320.8007519548905, 3391.609964854024, 5637.830865074055, 6497.667978064485, 6531.967340163269, 6621.0, 6667.633280169637, 6544.5785059527325, 6563.573367731177, 6568.967155164193, 6585.407313341726, 6599.591149230592, 6386.552941294065, 6530.640814755234, 6603.933960660428, 6623.503237257225, 6625.569337993015, 6395.296517382991, 6417.807465776034, 6420.518461115528, 6438.356164383524, 6443.162388889415, 6117.755289788537, 6307.936920630735, 6321.178246828067, 6325.746970121144, 6352.711919454442, 6569.507286953402, 6605.57063790852, 6639.103720997604, 6667.733290668513, 6690.933090669031, 4187.141635964559, 4204.327307630764, 4206.684498662551, 4216.789160542022, 4244.7877606118955, 5060.84817455477, 5587.547237718141, 6389.837030669848, 6436.388543088399, 6450.483961282992, 5599.720013999202, 6059.72731227087, 6203.844903877439, 6208.820324138399, 6226.346233645402, 5168.767405466688, 5982.670953097448, 6152.692365381802, 6199.845003874759, 6230.252369715482, 5518.668879867221, 6074.3925607438905, 6085.1785009023215, 6091.786787462417, 6103.267607887082, 5955.464008239279, 6199.132121503083, 6199.411055949678, 6202.534809889366, 6211.937880621136, 4955.058538877602, 5525.696086715269, 5573.972130139486, 6081.118237855575, 6105.511559075175], "value": 4496.95357931312, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.2634522709678, 851.7444766570031, 857.399820125912, 864.58067837099, 880.7049638371145, 13161.868381316184, 17648.0, 18292.45122646321, 18880.81119188808, 18901.905490472564, 14237.288135593231, 17295.39466118686, 17813.109344532786, 17826.910865445654, 17833.286668533245, 992.4442312305114, 1006.6879267427084, 1009.6567167163163, 1009.9141572966307, 1012.099231683802, 677.8203775999364, 698.2807708060706, 999.2954966748425, 1043.4261156364007, 1044.107288268531, 1078.6979645699178, 1079.4440862955546, 1079.578964203961, 1080.4273734920466, 1082.7726177502734, 1075.3279200499687, 1075.8547596074586, 1076.978460430787, 1077.7090185649909, 1083.0360978728938, 518.8728761453431, 528.2657106621799, 624.0, 789.7630710786741, 793.4802704228739, 16441.83558164415, 16916.323347066227, 16934.0, 16947.915260423742, 16993.23530441133, 16277.186140693037, 16480.17599120039, 16893.23980420872, 17049.7442538362, 17078.743818842726, 12942.805857912139, 13218.669533261746, 13235.867641323559, 13242.801357979639, 13261.668458288523, 3471.8090505022215, 3572.982135089334, 3626.437902125175, 3628.256207477461, 3628.6189950055127, 112106.0, 113200.43399782949, 113849.4307528457, 113853.0, 114966.42516787446, 11315.886841131483, 13289.800652990212, 13369.73260534784, 13608.251546164858, 13638.249896255802, 17792.46622601324, 19787.0, 19801.10895009728, 20185.59628807445, 20322.796772032387, 7637.885431718529, 7827.608619568999, 7831.412644051719, 7837.882431763528, 7843.9607801961765, 3823.9808800956375, 3849.4418309344987, 3873.1091848874917, 3879.437481565157, 3889.669378102836, 4234.0, 4294.184105020036, 4309.698321117492, 4310.80601372939, 4369.6722745794195, 940.7271891151489, 942.830290547708, 945.7257395355269, 946.5835032585641, 968.2689569375077, 578.5920925747338, 586.1647152807233, 594.872102497965, 601.2424345324922, 619.1672200889795, 10898.618548350769, 11679.474423650956, 11921.940390297994, 11930.701732456759, 11940.387215643163, 577.408156639448, 578.6007654718316, 578.7424596054715, 599.0804115682406, 611.7461253579803, 5425.7829686812875, 5550.197150439083, 5557.972210139004, 5589.245451863946, 5644.689542075143, 97413.02586974182, 98278.0, 98610.0, 100085.0, 100399.0, 73321.20145582565, 87634.0, 95254.0, 95702.5214873935, 97555.0, 81394.0, 82146.76779848307, 82853.58573207216, 83690.0, 85457.0, 7609.619519024137, 10357.171426285728, 10972.286801357886, 11160.386178759922, 11313.490892909675, 34012.82993585115, 42248.36627450529, 42299.7885010573, 42334.941626459586, 42716.0, 67464.6626766863, 71622.5259119375, 71899.36831851366, 73220.26779732348, 76949.84575231264, 12071.57749478764, 15664.553798164841, 15889.841101588836, 16057.357705691642, 16203.918980405022, 17808.10959452048, 18380.448586542425, 18704.625907481503, 18851.0, 18854.0, 16631.002139871645, 16808.159592020107, 17255.309787608356, 17276.481705548853, 17507.47477575675, 16387.09870957061, 16933.57666058309, 17121.657566848844, 17203.483895483154, 17304.567385815455, 15869.0, 16151.515454536382, 16810.495685129466, 16828.74756878623, 16834.07412592319, 10844.40355780408, 11808.645740627795, 11934.164608477324, 12158.635240942785, 12279.2018518796, 13026.739465210832, 13151.210927344007, 13169.407376668265, 13244.980280117288, 13337.466501339837], "value": 8213.031750829798, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1426.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 109.0, 111.0, 110.0, 111.0, 110.0, 112.0, 110.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 107.0, 106.0, 146.0, 105.0, 109.0, 107.0, 108.0, 137.0, 109.0], "value": 117.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 184.0, 186.0, 254.0, 215.0, 184.0, 184.0, 187.0, 184.0, 185.0], "value": 195.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 59.0, 87.0, 59.0, 57.0, 57.0, 59.0, 81.0, 57.0], "value": 65.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 69.0, 85.0, 70.0, 68.0, 67.0, 87.0, 69.0, 68.0, 89.0], "value": 76.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 87.0, 87.0, 87.0, 87.0, 88.0, 87.0, 88.0, 87.0], "value": 87.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 98.0, 94.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 129.0, 84.0, 85.0, 83.0, 83.0, 83.0, 86.0, 85.0, 84.0], "value": 90.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 49.0, 47.0, 50.0, 50.0, 51.0, 49.0, 48.0, 49.0], "value": 49.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 61.0, 64.0, 68.0, 62.0, 59.0, 58.0, 58.0, 58.0, 58.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 82.0, 83.0, 84.0, 82.0, 82.0, 82.0, 81.0, 84.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 128.0, 144.0, 151.0, 151.0, 128.0, 135.0, 137.0, 176.0, 149.0], "value": 144.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 182.0, 185.0, 185.0, 192.0, 182.0, 187.0, 181.0, 183.0, 185.0], "value": 184.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 69.0, 68.0, 67.0, 68.0, 69.0, 67.0, 68.0], "value": 67.7, "unit": "score"}]}]} 18:04:14 INFO - Return code: 0 18:04:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:04:14 ERROR - # TBPL SUCCESS # 18:04:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:04:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:04:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:04:14 INFO - 2017-04-26 18:04:14.166 screenresolution[1643:9731] starting screenresolution argv=screenresolution get 18:04:14 INFO - 2017-04-26 18:04:14.168 screenresolution[1643:9731] Display 0: 1600x1200x32@60 18:04:14 INFO - 2017-04-26 18:04:14.174 screenresolution[1644:9734] starting screenresolution argv=screenresolution list 18:04:14 INFO - Available Modes on Display 0 18:04:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:04:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:04:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:04:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:04:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:04:14 INFO - Intel Iris: 18:04:14 INFO - Chipset Model: Intel Iris 18:04:14 INFO - Type: GPU 18:04:14 INFO - Bus: Built-In 18:04:14 INFO - VRAM (Dynamic, Max): 1536 MB 18:04:14 INFO - Vendor: Intel (0x8086) 18:04:14 INFO - Device ID: 0x0a2e 18:04:14 INFO - Revision ID: 0x0009 18:04:14 INFO - Displays: 18:04:14 INFO - Display: 18:04:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:04:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:04:14 INFO - Display Serial Number: 1600x1200 60 18:04:14 INFO - Main Display: Yes 18:04:14 INFO - Mirror: Off 18:04:14 INFO - Online: Yes 18:04:14 INFO - Rotation: Supported 18:04:14 INFO - Return code: 0 18:04:14 INFO - Running post-action listener: _resource_record_post_action 18:04:14 INFO - [mozharness: 2017-04-27 01:04:14.414665Z] Finished run-tests step (success) 18:04:14 INFO - Running post-run listener: _resource_record_post_run 18:04:14 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 43258880; Write bytes: 509343232; Read time: 464; Write time: 1579 18:04:14 INFO - TinderboxPrint: CPU usage
53.2% 18:04:14 INFO - TinderboxPrint: I/O read bytes / time
43,258,880 / 464 18:04:14 INFO - TinderboxPrint: I/O write bytes / time
509,343,232 / 1,579 18:04:14 INFO - TinderboxPrint: CPU idle
2,246.7 (46.8%) 18:04:14 INFO - TinderboxPrint: CPU system
951.4 (19.8%) 18:04:14 INFO - TinderboxPrint: CPU user
1,599.6 (33.3%) 18:04:14 INFO - TinderboxPrint: Swap in / out
247,111,680 / 0 18:04:14 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209752576; Write bytes: 210826752; Read time: 16133; Write time: 452 18:04:14 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 38519808; Write bytes: 297029632; Read time: 424; Write time: 1121 18:04:14 INFO - Running post-run listener: _upload_blobber_files 18:04:14 INFO - Blob upload gear active. 18:04:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:04:14 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 18:04:14 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'] 18:04:14 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 18:04:15 INFO - (blobuploader) - INFO - Open directory for files ... 18:04:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:04:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:04:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:16 INFO - (blobuploader) - INFO - Done attempting. 18:04:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:04:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:04:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:17 INFO - (blobuploader) - INFO - Done attempting. 18:04:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:04:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:04:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:18 INFO - (blobuploader) - INFO - Done attempting. 18:04:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:04:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:04:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:20 INFO - (blobuploader) - INFO - Done attempting. 18:04:20 INFO - (blobuploader) - INFO - Iteration through files over. 18:04:20 INFO - Return code: 0 18:04:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:04:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:04:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8767dcbc05895a8fa67d51d77a89e7a270c4f375b962bc435b28f0e6afe5e3881f619126522da4316f568244dc049990e768fdc977827075c46327c275b97392", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/336bcdab27ea2ebde15aae28c6dab5e349d3235ad3b146d87b66978bcff2087f1fe24e74f60961a43b0d4215569acaed0146633e437bb0e37109d523847a8feb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/148772450fe17e3557a95ca6058fab9288f4b6df9c01b04f561c54e6b3ec84782eaadabea8e986862d5ffd8f04103e9882d89929c85ce282e5d164b9b9312bed", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e017dbc876971997af2f84c470360bc6850c41dda1d3dbfd1a074d6ce2ae9f617a9472724b0d3108b4280255f8ddd3d586843b00b8453787ef19406c5891c723"} 18:04:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:04:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:04:20 INFO - Contents: 18:04:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8767dcbc05895a8fa67d51d77a89e7a270c4f375b962bc435b28f0e6afe5e3881f619126522da4316f568244dc049990e768fdc977827075c46327c275b97392", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/336bcdab27ea2ebde15aae28c6dab5e349d3235ad3b146d87b66978bcff2087f1fe24e74f60961a43b0d4215569acaed0146633e437bb0e37109d523847a8feb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/148772450fe17e3557a95ca6058fab9288f4b6df9c01b04f561c54e6b3ec84782eaadabea8e986862d5ffd8f04103e9882d89929c85ce282e5d164b9b9312bed", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e017dbc876971997af2f84c470360bc6850c41dda1d3dbfd1a074d6ce2ae9f617a9472724b0d3108b4280255f8ddd3d586843b00b8453787ef19406c5891c723"} 18:04:20 INFO - Running post-run listener: copy_logs_to_upload_dir 18:04:20 INFO - Copying logs to upload dir... 18:04:20 INFO - mkdir: /builds/slave/test/build/upload/logs 18:04:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.103033 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-04-26 18:04:20.741697) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-26 18:04:20.745386) ========= 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.2k1eQLne1N/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.uIpFTzjhxZ/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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/8767dcbc05895a8fa67d51d77a89e7a270c4f375b962bc435b28f0e6afe5e3881f619126522da4316f568244dc049990e768fdc977827075c46327c275b97392", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/336bcdab27ea2ebde15aae28c6dab5e349d3235ad3b146d87b66978bcff2087f1fe24e74f60961a43b0d4215569acaed0146633e437bb0e37109d523847a8feb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/148772450fe17e3557a95ca6058fab9288f4b6df9c01b04f561c54e6b3ec84782eaadabea8e986862d5ffd8f04103e9882d89929c85ce282e5d164b9b9312bed", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e017dbc876971997af2f84c470360bc6850c41dda1d3dbfd1a074d6ce2ae9f617a9472724b0d3108b4280255f8ddd3d586843b00b8453787ef19406c5891c723"} build_url:https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011066 build_url: 'https://queue.taskcluster.net/v1/task/Eh3HJlFrRNO8kXhFOxFGaw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8767dcbc05895a8fa67d51d77a89e7a270c4f375b962bc435b28f0e6afe5e3881f619126522da4316f568244dc049990e768fdc977827075c46327c275b97392", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/336bcdab27ea2ebde15aae28c6dab5e349d3235ad3b146d87b66978bcff2087f1fe24e74f60961a43b0d4215569acaed0146633e437bb0e37109d523847a8feb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/148772450fe17e3557a95ca6058fab9288f4b6df9c01b04f561c54e6b3ec84782eaadabea8e986862d5ffd8f04103e9882d89929c85ce282e5d164b9b9312bed", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e017dbc876971997af2f84c470360bc6850c41dda1d3dbfd1a074d6ce2ae9f617a9472724b0d3108b4280255f8ddd3d586843b00b8453787ef19406c5891c723"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-26 18:04:20.783755) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 18:04:20.784094) ========= 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.2k1eQLne1N/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.uIpFTzjhxZ/Listeners TMPDIR=/var/folders/zb/gjztv1j9199774r50d3phz4m00000w/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.005026 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 18:04:20.832759) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-26 18:04:20.833218) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-26 18:04:20.833656) ========= ========= Total master_lag: 0.19 =========