builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0201 starttime: 1491767846.55 results: success (0) buildid: 20170409113321 builduid: 20c273fcb3674aceae8d738e3841134b revision: 60fe200cb8dbd21695eae5775bec9305a9c900b6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-09 12:57:26.554675) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-09 12:57:26.555090) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-09 12:57:26.555364) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-09 12:57:26.635763) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 12:57:26.636013) ========= 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.yXBjBQTVwL/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.k0qadRKOjp/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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-09 12:57:26-- 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% 171M=0s 2017-04-09 12:57:27 (171 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.485854 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 12:57:27.145649) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 12:57:27.145966) ========= 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.yXBjBQTVwL/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.k0qadRKOjp/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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.030884 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 12:57:27.199525) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 12:57:27.199933) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 60fe200cb8dbd21695eae5775bec9305a9c900b6 --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 60fe200cb8dbd21695eae5775bec9305a9c900b6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yXBjBQTVwL/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.k0qadRKOjp/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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-09 12:57:27,308 truncating revision to first 12 chars 2017-04-09 12:57:27,308 Setting DEBUG logging. 2017-04-09 12:57:27,308 attempt 1/10 2017-04-09 12:57:27,308 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/60fe200cb8db?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-09 12:57:27,976 unpacking tar archive at: mozilla-central-60fe200cb8db/testing/mozharness/ program finished with exit code 0 elapsedTime=0.957875 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 12:57:28.181146) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-09 12:57:28.181451) ========= script_repo_revision: 60fe200cb8dbd21695eae5775bec9305a9c900b6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-09 12:57:28.181847) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-09 12:57:28.182157) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-09 12:57:28.201795) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-04-09 12:57:28.202073) ========= /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.yXBjBQTVwL/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.k0qadRKOjp/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 12:57:28 INFO - MultiFileLogger online at 20170409 12:57:28 in /builds/slave/test 12:57:28 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 12:57:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:57:28 INFO - {'append_to_log': False, 12:57:28 INFO - 'base_work_dir': '/builds/slave/test', 12:57:28 INFO - 'blob_upload_branch': 'Firefox', 12:57:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:57:28 INFO - 'branch': 'Firefox', 12:57:28 INFO - 'buildbot_json_path': 'buildprops.json', 12:57:28 INFO - 'config_files': ('talos/mac_config.py',), 12:57:28 INFO - 'default_actions': ('clobber', 12:57:28 INFO - 'read-buildbot-config', 12:57:28 INFO - 'download-and-extract', 12:57:28 INFO - 'populate-webroot', 12:57:28 INFO - 'create-virtualenv', 12:57:28 INFO - 'install', 12:57:28 INFO - 'run-tests'), 12:57:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:57:28 INFO - 'download_minidump_stackwalk': True, 12:57:28 INFO - 'download_symbols': 'ondemand', 12:57:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:57:28 INFO - 'tooltool.py': '/tools/tooltool.py', 12:57:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:57:28 INFO - '/tools/misc-python/virtualenv.py')}, 12:57:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:57:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:57:28 INFO - 'gecko_profile': False, 12:57:28 INFO - 'gecko_profile_interval': 0, 12:57:28 INFO - 'installer_path': 'installer.exe', 12:57:28 INFO - 'log_level': 'info', 12:57:28 INFO - 'log_name': 'talos', 12:57:28 INFO - 'log_to_console': True, 12:57:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:57:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:57:28 INFO - 'opt_config_files': (), 12:57:28 INFO - 'pip_index': False, 12:57:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:57:28 INFO - 'cmd': ('bash', 12:57:28 INFO - '-c', 12:57:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:57:28 INFO - 'enabled': True, 12:57:28 INFO - 'halt_on_failure': False, 12:57:28 INFO - 'name': 'check_screen_resolution'},), 12:57:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:57:28 INFO - 'cmd': ('bash', 12:57:28 INFO - '-c', 12:57:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:57:28 INFO - 'enabled': True, 12:57:28 INFO - 'halt_on_failure': False, 12:57:28 INFO - 'name': 'check_screen_resolution'},), 12:57:28 INFO - 'run_cmd_checks_enabled': True, 12:57:28 INFO - 'suite': 'dromaeojs', 12:57:28 INFO - 'system_bits': '32', 12:57:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:57:28 INFO - 'title': 't-yosemite-r7-0201', 12:57:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:57:28 INFO - 'use_talos_json': True, 12:57:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:57:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:57:28 INFO - 'work_dir': 'build'} 12:57:28 INFO - [mozharness: 2017-04-09 19:57:28.417187Z] Running clobber step. 12:57:28 INFO - Running pre-action listener: _resource_record_pre_action 12:57:28 INFO - Running main action method: clobber 12:57:28 INFO - rmtree: /builds/slave/test/build 12:57:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:57:30 INFO - Running post-action listener: _resource_record_post_action 12:57:30 INFO - [mozharness: 2017-04-09 19:57:30.788012Z] Finished clobber step (success) 12:57:30 INFO - [mozharness: 2017-04-09 19:57:30.788204Z] Running read-buildbot-config step. 12:57:30 INFO - Running pre-action listener: _resource_record_pre_action 12:57:30 INFO - Running main action method: read_buildbot_config 12:57:30 INFO - Using buildbot properties: 12:57:30 INFO - { 12:57:30 INFO - "project": "", 12:57:30 INFO - "product": "firefox", 12:57:30 INFO - "script_repo_revision": "production", 12:57:30 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 12:57:30 INFO - "repository": "", 12:57:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 12:57:30 INFO - "buildid": "20170409113321", 12:57:30 INFO - "pgo_build": "False", 12:57:30 INFO - "basedir": "/builds/slave/test", 12:57:30 INFO - "buildnumber": 24, 12:57:30 INFO - "slavename": "t-yosemite-r7-0201", 12:57:30 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 12:57:30 INFO - "platform": "yosemite_r7", 12:57:30 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 12:57:30 INFO - "branch": "mozilla-central", 12:57:30 INFO - "repo_path": "mozilla-central", 12:57:30 INFO - "revision": "60fe200cb8dbd21695eae5775bec9305a9c900b6", 12:57:30 INFO - "stage_platform": "macosx64", 12:57:30 INFO - "builduid": "20c273fcb3674aceae8d738e3841134b", 12:57:30 INFO - "slavebuilddir": "test" 12:57:30 INFO - } 12:57:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/TCEdOkYOTe6xZGXsEyMtvA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 12:57:30 INFO - Running post-action listener: _resource_record_post_action 12:57:30 INFO - [mozharness: 2017-04-09 19:57:30.791515Z] Finished read-buildbot-config step (success) 12:57:30 INFO - [mozharness: 2017-04-09 19:57:30.791648Z] Running download-and-extract step. 12:57:30 INFO - Running pre-action listener: _resource_record_pre_action 12:57:30 INFO - Running main action method: download_and_extract 12:57:30 INFO - mkdir: /builds/slave/test/build/tests 12:57:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:30 INFO - trying https://queue.taskcluster.net/v1/task/TCEdOkYOTe6xZGXsEyMtvA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 12:57:30 INFO - Downloading https://queue.taskcluster.net/v1/task/TCEdOkYOTe6xZGXsEyMtvA/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 12:57:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TCEdOkYOTe6xZGXsEyMtvA/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 12:57:32 INFO - Downloaded 1325 bytes. 12:57:32 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 12:57:32 INFO - Using the following test package requirements: 12:57:32 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:57:32 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 12:57:32 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 12:57:32 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:57:32 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 12:57:32 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:57:32 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 12:57:32 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:57:32 INFO - u'jsshell-mac.zip'], 12:57:32 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:57:32 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 12:57:32 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 12:57:32 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:57:32 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 12:57:32 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:57:32 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 12:57:32 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:57:32 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 12:57:32 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:57:32 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 12:57:32 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:57:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TCEdOkYOTe6xZGXsEyMtvA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 12:57:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TCEdOkYOTe6xZGXsEyMtvA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:57:32 INFO - Fetch https://queue.taskcluster.net/v1/task/TCEdOkYOTe6xZGXsEyMtvA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 12:57:35 INFO - Expected file size: 52526629 12:57:35 INFO - Obtained file size: 52526629 12:57:51 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 12:57:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TCEdOkYOTe6xZGXsEyMtvA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 12:57:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TCEdOkYOTe6xZGXsEyMtvA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:57:51 INFO - Fetch https://queue.taskcluster.net/v1/task/TCEdOkYOTe6xZGXsEyMtvA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 12:57:53 INFO - Expected file size: 52526629 12:57:53 INFO - Obtained file size: 52526629 12:58:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TCEdOkYOTe6xZGXsEyMtvA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 12:58:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TCEdOkYOTe6xZGXsEyMtvA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:58:08 INFO - Fetch https://queue.taskcluster.net/v1/task/TCEdOkYOTe6xZGXsEyMtvA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 12:58:10 INFO - Expected file size: 14404129 12:58:10 INFO - Obtained file size: 14404129 12:58:10 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')]} 12:58:10 INFO - trying https://queue.taskcluster.net/v1/task/TCEdOkYOTe6xZGXsEyMtvA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:58:10 INFO - Downloading https://queue.taskcluster.net/v1/task/TCEdOkYOTe6xZGXsEyMtvA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 12:58:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TCEdOkYOTe6xZGXsEyMtvA/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 12:58:12 INFO - Downloaded 70929998 bytes. 12:58:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TCEdOkYOTe6xZGXsEyMtvA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:58:12 INFO - mkdir: /builds/slave/test/properties 12:58:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:58:12 INFO - Writing to file /builds/slave/test/properties/build_url 12:58:12 INFO - Contents: 12:58:12 INFO - build_url:https://queue.taskcluster.net/v1/task/TCEdOkYOTe6xZGXsEyMtvA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:58:13 INFO - Running post-action listener: _resource_record_post_action 12:58:13 INFO - Running post-action listener: set_extra_try_arguments 12:58:13 INFO - [mozharness: 2017-04-09 19:58:13.596166Z] Finished download-and-extract step (success) 12:58:13 INFO - [mozharness: 2017-04-09 19:58:13.596274Z] Running populate-webroot step. 12:58:13 INFO - Running pre-action listener: _resource_record_pre_action 12:58:13 INFO - Running main action method: populate_webroot 12:58:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:58:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:58:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:58:13 INFO - '--tppagecycles', 12:58:13 INFO - '7'], 12:58:13 INFO - 'tests': ['tsvgm']}}, 12:58:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:58:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:58:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:58:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:58:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:58:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:58:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:58:13 INFO - 'talos_options': ['--disable-e10s'], 12:58:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:58:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:58:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:58:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:58:13 INFO - 'talos_options': ['--disable-e10s'], 12:58:13 INFO - 'tests': ['damp', 'tps']}, 12:58:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:58:13 INFO - 'tests': ['damp', 'tps']}, 12:58:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:58:13 INFO - 'tests': ['dromaeo_dom']}, 12:58:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:58:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:58:13 INFO - 'tests': ['basic_compositor_video']}, 12:58:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:58:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:58:13 INFO - 'tests': ['a11yr', 12:58:13 INFO - 'ts_paint', 12:58:13 INFO - 'tpaint', 12:58:13 INFO - 'sessionrestore', 12:58:13 INFO - 'sessionrestore_no_auto_restore', 12:58:13 INFO - 'tabpaint']}, 12:58:13 INFO - 'other-e10s': {'tests': ['a11yr', 12:58:13 INFO - 'ts_paint', 12:58:13 INFO - 'tpaint', 12:58:13 INFO - 'sessionrestore', 12:58:13 INFO - 'sessionrestore_no_auto_restore', 12:58:13 INFO - 'tabpaint']}, 12:58:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:58:13 INFO - 'ts_paint', 12:58:13 INFO - 'tpaint', 12:58:13 INFO - 'sessionrestore', 12:58:13 INFO - 'sessionrestore_no_auto_restore', 12:58:13 INFO - 'tabpaint']}, 12:58:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:58:13 INFO - 'ts_paint', 12:58:13 INFO - 'tpaint', 12:58:13 INFO - 'sessionrestore', 12:58:13 INFO - 'sessionrestore_no_auto_restore', 12:58:13 INFO - 'tabpaint']}, 12:58:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:58:13 INFO - 'tests': ['a11yr', 12:58:13 INFO - 'ts_paint', 12:58:13 INFO - 'tpaint', 12:58:13 INFO - 'sessionrestore', 12:58:13 INFO - 'sessionrestore_no_auto_restore', 12:58:13 INFO - 'tabpaint']}, 12:58:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:58:13 INFO - 'tests': ['a11yr', 12:58:13 INFO - 'ts_paint', 12:58:13 INFO - 'tpaint', 12:58:13 INFO - 'sessionrestore', 12:58:13 INFO - 'sessionrestore_no_auto_restore', 12:58:13 INFO - 'tabpaint']}, 12:58:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:58:13 INFO - 'tests': ['tsvgx', 12:58:13 INFO - 'tsvgr_opacity', 12:58:13 INFO - 'tart', 12:58:13 INFO - 'tscrollx', 12:58:13 INFO - 'cart', 12:58:13 INFO - 'tsvg_static']}, 12:58:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:58:13 INFO - 'tsvgr_opacity', 12:58:13 INFO - 'tart', 12:58:13 INFO - 'tscrollx', 12:58:13 INFO - 'cart', 12:58:13 INFO - 'tsvg_static']}, 12:58:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:58:13 INFO - 'talos_options': ['--disable-e10s'], 12:58:13 INFO - 'tests': ['tp5o']}, 12:58:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:58:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:58:13 INFO - 'talos_options': ['--disable-e10s', 12:58:13 INFO - '--xperf_path', 12:58:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:58:13 INFO - 'tests': ['tp5n']}, 12:58:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:58:13 INFO - 'talos_options': ['--xperf_path', 12:58:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:58:13 INFO - 'tests': ['tp5n']}}, 12:58:13 INFO - 'talos.zip': {'path': '', 12:58:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:58:13 INFO - Running post-action listener: _resource_record_post_action 12:58:13 INFO - [mozharness: 2017-04-09 19:58:13.614861Z] Finished populate-webroot step (success) 12:58:13 INFO - [mozharness: 2017-04-09 19:58:13.614969Z] Running create-virtualenv step. 12:58:13 INFO - Running pre-action listener: _resource_record_pre_action 12:58:13 INFO - Running main action method: create_virtualenv 12:58:13 INFO - Creating virtualenv /builds/slave/test/build/venv 12:58:13 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 12:58:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:58:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:58:13 INFO - Using real prefix '/tools/python27' 12:58:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:58:14 INFO - Installing distribute.............................................................................................................................................................................................done. 12:58:17 INFO - Installing pip.................done. 12:58:17 INFO - Return code: 0 12:58:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:58:17 INFO - Reading from file tmpfile_stdout 12:58:17 INFO - Output received: 12:58:17 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) 12:58:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:17 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 0x10e4d2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4d5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3e1dc3530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b0d30>, '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 0x10e1d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a5be8>, '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.yXBjBQTVwL/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.k0qadRKOjp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 12:58:17 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 12:58:17 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 12:58:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yXBjBQTVwL/Render', 12:58:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:58:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:58:17 INFO - 'HOME': '/Users/cltbld', 12:58:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:58:17 INFO - 'LOGNAME': 'cltbld', 12:58:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:17 INFO - 'MOZ_NO_REMOTE': '1', 12:58:17 INFO - 'NO_EM_RESTART': '1', 12:58:17 INFO - 'PAGER': '/bin/cat', 12:58:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:58:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:17 INFO - 'PWD': '/builds/slave/test', 12:58:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:58:17 INFO - 'SHELL': '/bin/bash', 12:58:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0qadRKOjp/Listeners', 12:58:17 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 12:58:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:58:17 INFO - 'USER': 'cltbld', 12:58:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:58:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:58:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:17 INFO - 'XPC_FLAGS': '0x0', 12:58:17 INFO - 'XPC_SERVICE_NAME': '0', 12:58:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:58:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:17 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 12:58:17 INFO - Cleaning up... 12:58:17 INFO - Return code: 0 12:58:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:17 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 0x10e4d2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4d5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3e1dc3530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b0d30>, '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 0x10e1d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a5be8>, '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.yXBjBQTVwL/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.k0qadRKOjp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 12:58:17 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 12:58:17 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 12:58:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yXBjBQTVwL/Render', 12:58:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:58:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:58:17 INFO - 'HOME': '/Users/cltbld', 12:58:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:58:17 INFO - 'LOGNAME': 'cltbld', 12:58:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:17 INFO - 'MOZ_NO_REMOTE': '1', 12:58:17 INFO - 'NO_EM_RESTART': '1', 12:58:17 INFO - 'PAGER': '/bin/cat', 12:58:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:58:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:17 INFO - 'PWD': '/builds/slave/test', 12:58:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:58:17 INFO - 'SHELL': '/bin/bash', 12:58:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0qadRKOjp/Listeners', 12:58:17 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 12:58:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:58:17 INFO - 'USER': 'cltbld', 12:58:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:58:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:58:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:17 INFO - 'XPC_FLAGS': '0x0', 12:58:17 INFO - 'XPC_SERVICE_NAME': '0', 12:58:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:18 INFO - Downloading/unpacking psutil>=3.1.1 12:58:18 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 12:58:18 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 12:58:18 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 12:58:18 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 12:58:18 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 12:58:18 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 12:58:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:58:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:58:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:58:22 INFO - Installing collected packages: psutil 12:58:22 INFO - Running setup.py install for psutil 12:58:22 INFO - building 'psutil._psutil_osx' extension 12:58:22 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 12:58:22 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 12:58:22 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 12:58:22 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 12:58:22 INFO - building 'psutil._psutil_posix' extension 12:58:22 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 12:58:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:58:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:58:23 INFO - ^ 12:58:23 INFO - 1 warning generated. 12:58:23 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 12:58:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:58:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:58:23 INFO - Successfully installed psutil 12:58:23 INFO - Cleaning up... 12:58:23 INFO - Return code: 0 12:58:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e4d2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4d5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3e1dc3530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b0d30>, '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 0x10e1d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a5be8>, '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.yXBjBQTVwL/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.k0qadRKOjp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 12:58:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:58:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:58:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yXBjBQTVwL/Render', 12:58:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:58:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:58:23 INFO - 'HOME': '/Users/cltbld', 12:58:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:58:23 INFO - 'LOGNAME': 'cltbld', 12:58:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:23 INFO - 'MOZ_NO_REMOTE': '1', 12:58:23 INFO - 'NO_EM_RESTART': '1', 12:58:23 INFO - 'PAGER': '/bin/cat', 12:58:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:58:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:23 INFO - 'PWD': '/builds/slave/test', 12:58:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:58:23 INFO - 'SHELL': '/bin/bash', 12:58:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0qadRKOjp/Listeners', 12:58:23 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 12:58:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:58:23 INFO - 'USER': 'cltbld', 12:58:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:58:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:58:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:23 INFO - 'XPC_FLAGS': '0x0', 12:58:23 INFO - 'XPC_SERVICE_NAME': '0', 12:58:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:58:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:58:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:58:26 INFO - Installing collected packages: mozsystemmonitor 12:58:26 INFO - Running setup.py install for mozsystemmonitor 12:58:26 INFO - Successfully installed mozsystemmonitor 12:58:26 INFO - Cleaning up... 12:58:26 INFO - Return code: 0 12:58:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e4d2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4d5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3e1dc3530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b0d30>, '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 0x10e1d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a5be8>, '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.yXBjBQTVwL/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.k0qadRKOjp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 12:58:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:58:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:58:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yXBjBQTVwL/Render', 12:58:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:58:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:58:26 INFO - 'HOME': '/Users/cltbld', 12:58:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:58:26 INFO - 'LOGNAME': 'cltbld', 12:58:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:26 INFO - 'MOZ_NO_REMOTE': '1', 12:58:26 INFO - 'NO_EM_RESTART': '1', 12:58:26 INFO - 'PAGER': '/bin/cat', 12:58:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:58:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:26 INFO - 'PWD': '/builds/slave/test', 12:58:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:58:26 INFO - 'SHELL': '/bin/bash', 12:58:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0qadRKOjp/Listeners', 12:58:26 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 12:58:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:58:26 INFO - 'USER': 'cltbld', 12:58:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:58:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:58:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:26 INFO - 'XPC_FLAGS': '0x0', 12:58:26 INFO - 'XPC_SERVICE_NAME': '0', 12:58:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:58:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:26 INFO - Downloading/unpacking jsonschema==2.5.1 12:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:58:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:29 INFO - Downloading functools32-3.2.3-2.tar.gz 12:58:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:58:29 INFO - warning: no files found matching '*.txt' 12:58:29 INFO - no previously-included directories found matching 'build' 12:58:29 INFO - no previously-included directories found matching 'dist' 12:58:29 INFO - no previously-included directories found matching '.git*' 12:58:29 INFO - Installing collected packages: jsonschema, functools32 12:58:30 INFO - Running setup.py install for functools32 12:58:30 INFO - warning: no files found matching '*.txt' 12:58:30 INFO - no previously-included directories found matching 'build' 12:58:30 INFO - no previously-included directories found matching 'dist' 12:58:30 INFO - no previously-included directories found matching '.git*' 12:58:30 INFO - Successfully installed jsonschema functools32 12:58:30 INFO - Cleaning up... 12:58:30 INFO - Return code: 0 12:58:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e4d2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4d5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3e1dc3530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b0d30>, '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 0x10e1d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a5be8>, '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.yXBjBQTVwL/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.k0qadRKOjp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 12:58:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:58:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:58:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yXBjBQTVwL/Render', 12:58:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:58:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:58:30 INFO - 'HOME': '/Users/cltbld', 12:58:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:58:30 INFO - 'LOGNAME': 'cltbld', 12:58:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:30 INFO - 'MOZ_NO_REMOTE': '1', 12:58:30 INFO - 'NO_EM_RESTART': '1', 12:58:30 INFO - 'PAGER': '/bin/cat', 12:58:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:58:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:30 INFO - 'PWD': '/builds/slave/test', 12:58:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:58:30 INFO - 'SHELL': '/bin/bash', 12:58:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0qadRKOjp/Listeners', 12:58:30 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 12:58:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:58:30 INFO - 'USER': 'cltbld', 12:58:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:58:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:58:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:30 INFO - 'XPC_FLAGS': '0x0', 12:58:30 INFO - 'XPC_SERVICE_NAME': '0', 12:58:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:58:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:58:30 INFO - Cleaning up... 12:58:30 INFO - Return code: 0 12:58:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e4d2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4d5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3e1dc3530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b0d30>, '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 0x10e1d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a5be8>, '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.yXBjBQTVwL/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.k0qadRKOjp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 12:58:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:58:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:58:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yXBjBQTVwL/Render', 12:58:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:58:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:58:30 INFO - 'HOME': '/Users/cltbld', 12:58:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:58:30 INFO - 'LOGNAME': 'cltbld', 12:58:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:30 INFO - 'MOZ_NO_REMOTE': '1', 12:58:30 INFO - 'NO_EM_RESTART': '1', 12:58:30 INFO - 'PAGER': '/bin/cat', 12:58:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:58:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:30 INFO - 'PWD': '/builds/slave/test', 12:58:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:58:30 INFO - 'SHELL': '/bin/bash', 12:58:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0qadRKOjp/Listeners', 12:58:30 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 12:58:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:58:30 INFO - 'USER': 'cltbld', 12:58:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:58:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:58:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:30 INFO - 'XPC_FLAGS': '0x0', 12:58:30 INFO - 'XPC_SERVICE_NAME': '0', 12:58:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:58:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:30 INFO - Downloading/unpacking blobuploader==1.2.4 12:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:33 INFO - Downloading blobuploader-1.2.4.tar.gz 12:58:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:58:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:58:33 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 12:58:33 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 12:58:33 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 12:58:33 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 12:58:33 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 12:58:33 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 12:58:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:58:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:34 INFO - Downloading docopt-0.6.1.tar.gz 12:58:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:58:34 INFO - Installing collected packages: blobuploader, requests, docopt 12:58:34 INFO - Running setup.py install for blobuploader 12:58:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:58:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:58:34 INFO - Running setup.py install for requests 12:58:35 INFO - Running setup.py install for docopt 12:58:35 INFO - Successfully installed blobuploader requests docopt 12:58:35 INFO - Cleaning up... 12:58:35 INFO - Return code: 0 12:58:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:35 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 0x10e4d2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4d5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3e1dc3530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b0d30>, '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 0x10e1d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a5be8>, '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.yXBjBQTVwL/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.k0qadRKOjp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 12:58:35 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 12:58:35 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 12:58:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yXBjBQTVwL/Render', 12:58:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:58:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:58:35 INFO - 'HOME': '/Users/cltbld', 12:58:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:58:35 INFO - 'LOGNAME': 'cltbld', 12:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:35 INFO - 'MOZ_NO_REMOTE': '1', 12:58:35 INFO - 'NO_EM_RESTART': '1', 12:58:35 INFO - 'PAGER': '/bin/cat', 12:58:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:35 INFO - 'PWD': '/builds/slave/test', 12:58:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:58:35 INFO - 'SHELL': '/bin/bash', 12:58:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0qadRKOjp/Listeners', 12:58:35 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 12:58:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:58:35 INFO - 'USER': 'cltbld', 12:58:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:58:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:35 INFO - 'XPC_FLAGS': '0x0', 12:58:35 INFO - 'XPC_SERVICE_NAME': '0', 12:58:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:58:35 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-Krdff8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:58:36 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-ejvFeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:58:36 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-zJqDnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:58:36 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-fnyrF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:58:36 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-GopHfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:58:36 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-oEdhJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:58:36 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-O68hB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:58:36 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-LzMzck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:58:36 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-87z4zK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:58:36 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-XUUHJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:58:37 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-HjyVJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:58:37 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-r_qeOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:58:37 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-lRk4Ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:58:37 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-rnKvo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:58:37 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-HOMSKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:58:37 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-FbALX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:58:37 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-sJ_ret-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:58:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:58:37 INFO - Running setup.py install for manifestparser 12:58:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:58:37 INFO - Running setup.py install for mozcrash 12:58:38 INFO - Running setup.py install for mozdebug 12:58:38 INFO - Running setup.py install for mozdevice 12:58:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:58:38 INFO - Running setup.py install for mozfile 12:58:38 INFO - Running setup.py install for mozhttpd 12:58:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:58:38 INFO - Running setup.py install for mozinfo 12:58:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:58:38 INFO - Running setup.py install for mozInstall 12:58:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:58:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:58:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:58:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:58:38 INFO - Running setup.py install for mozleak 12:58:39 INFO - Running setup.py install for mozlog 12:58:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:58:39 INFO - Running setup.py install for moznetwork 12:58:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:58:39 INFO - Running setup.py install for mozprocess 12:58:39 INFO - Running setup.py install for mozprofile 12:58:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:58:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:58:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:58:39 INFO - Running setup.py install for mozrunner 12:58:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:58:39 INFO - Running setup.py install for mozscreenshot 12:58:39 INFO - Running setup.py install for moztest 12:58:40 INFO - Running setup.py install for mozversion 12:58:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:58:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:58:40 INFO - Cleaning up... 12:58:40 INFO - Return code: 0 12:58:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:58:40 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')]} 12:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:40 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')]} 12:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:40 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 0x10e4d2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4d5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3e1dc3530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b0d30>, '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 0x10e1d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a5be8>, '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.yXBjBQTVwL/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.k0qadRKOjp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 12:58:40 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 12:58:40 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 12:58:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yXBjBQTVwL/Render', 12:58:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:58:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:58:40 INFO - 'HOME': '/Users/cltbld', 12:58:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:58:40 INFO - 'LOGNAME': 'cltbld', 12:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:40 INFO - 'MOZ_NO_REMOTE': '1', 12:58:40 INFO - 'NO_EM_RESTART': '1', 12:58:40 INFO - 'PAGER': '/bin/cat', 12:58:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:40 INFO - 'PWD': '/builds/slave/test', 12:58:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:58:40 INFO - 'SHELL': '/bin/bash', 12:58:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0qadRKOjp/Listeners', 12:58:40 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 12:58:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:58:40 INFO - 'USER': 'cltbld', 12:58:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:58:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:40 INFO - 'XPC_FLAGS': '0x0', 12:58:40 INFO - 'XPC_SERVICE_NAME': '0', 12:58:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:58:40 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-fo86Fc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:58:40 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)) 12:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:58:40 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-3J74TL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:58:40 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)) 12:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:58:40 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-Lgdazp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:58:40 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)) 12:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:58:40 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-VqoIAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:58:40 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)) 12:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:58:41 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-UCTI1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:58:41 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)) 12:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:58:41 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-_cnh_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:58:41 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)) 12:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:58:41 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-VhKheD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:58:41 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)) 12:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:58:41 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-qMNPJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:58:41 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)) 12:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:58:41 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-SQlZ_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:58:41 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)) 12:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:58:41 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-heVO_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:58:41 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)) 12:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:58:41 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-hrkpVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:58:41 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)) 12:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:58:41 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-Et31Kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:58:41 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)) 12:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:58:41 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-oUalAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:58:41 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)) 12:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:58:41 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-8z1MX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:58:42 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)) 12:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:58:42 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-qAZ4O3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:58:42 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)) 12:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:58:42 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-QeTuj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:58:42 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)) 12:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:58:42 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-Gti5PY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:58:42 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)) 12:58:42 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)) 12:58:42 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)) 12:58:42 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)) 12:58:42 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)) 12:58:42 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)) 12:58:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:58:42 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 12:58:42 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 12:58:42 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 12:58:42 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 12:58:42 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 12:58:42 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 12:58:44 INFO - Downloading blessings-1.6.tar.gz 12:58:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:58:45 INFO - Installing collected packages: blessings 12:58:45 INFO - Running setup.py install for blessings 12:58:45 INFO - Successfully installed blessings 12:58:45 INFO - Cleaning up... 12:58:45 INFO - Return code: 0 12:58:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:58:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:58:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:58:45 INFO - Reading from file tmpfile_stdout 12:58:45 INFO - Current package versions: 12:58:45 INFO - blessings == 1.6 12:58:45 INFO - blobuploader == 1.2.4 12:58:45 INFO - docopt == 0.6.1 12:58:45 INFO - functools32 == 3.2.3-2 12:58:45 INFO - jsonschema == 2.5.1 12:58:45 INFO - manifestparser == 1.1 12:58:45 INFO - mozInstall == 1.12 12:58:45 INFO - mozcrash == 1.0 12:58:45 INFO - mozdebug == 0.1 12:58:45 INFO - mozdevice == 0.50 12:58:45 INFO - mozfile == 1.2 12:58:45 INFO - mozhttpd == 0.7 12:58:45 INFO - mozinfo == 0.9 12:58:45 INFO - mozleak == 0.1 12:58:45 INFO - mozlog == 3.4 12:58:45 INFO - moznetwork == 0.27 12:58:45 INFO - mozprocess == 0.25 12:58:45 INFO - mozprofile == 0.28 12:58:45 INFO - mozrunner == 6.13 12:58:45 INFO - mozscreenshot == 0.1 12:58:45 INFO - mozsystemmonitor == 0.3 12:58:45 INFO - moztest == 0.8 12:58:45 INFO - mozversion == 1.4 12:58:45 INFO - psutil == 3.1.1 12:58:45 INFO - requests == 1.2.3 12:58:45 INFO - wsgiref == 0.1.2 12:58:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:45 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 0x10e4d2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4d5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3e1dc3530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b0d30>, '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 0x10e1d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a5be8>, '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.yXBjBQTVwL/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.k0qadRKOjp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 12:58:45 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 12:58:45 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 12:58:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yXBjBQTVwL/Render', 12:58:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:58:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:58:45 INFO - 'HOME': '/Users/cltbld', 12:58:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:58:45 INFO - 'LOGNAME': 'cltbld', 12:58:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:45 INFO - 'MOZ_NO_REMOTE': '1', 12:58:45 INFO - 'NO_EM_RESTART': '1', 12:58:45 INFO - 'PAGER': '/bin/cat', 12:58:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:58:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:45 INFO - 'PWD': '/builds/slave/test', 12:58:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:58:45 INFO - 'SHELL': '/bin/bash', 12:58:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0qadRKOjp/Listeners', 12:58:45 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 12:58:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:58:45 INFO - 'USER': 'cltbld', 12:58:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:58:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:58:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:45 INFO - 'XPC_FLAGS': '0x0', 12:58:45 INFO - 'XPC_SERVICE_NAME': '0', 12:58:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:45 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)) 12:58:45 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)) 12:58:45 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)) 12:58:45 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)) 12:58:45 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)) 12:58:45 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)) 12:58:45 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)) 12:58:45 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)) 12:58:45 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)) 12:58:45 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)) 12:58:45 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)) 12:58:45 INFO - Cleaning up... 12:58:45 INFO - Return code: 0 12:58:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e4d2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4d5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3e1dc3530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b0d30>, '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 0x10e1d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a5be8>, '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.yXBjBQTVwL/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.k0qadRKOjp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 12:58:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:58:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:58:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yXBjBQTVwL/Render', 12:58:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:58:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:58:45 INFO - 'HOME': '/Users/cltbld', 12:58:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:58:45 INFO - 'LOGNAME': 'cltbld', 12:58:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:45 INFO - 'MOZ_NO_REMOTE': '1', 12:58:45 INFO - 'NO_EM_RESTART': '1', 12:58:45 INFO - 'PAGER': '/bin/cat', 12:58:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:58:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:45 INFO - 'PWD': '/builds/slave/test', 12:58:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:58:45 INFO - 'SHELL': '/bin/bash', 12:58:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0qadRKOjp/Listeners', 12:58:45 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 12:58:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:58:45 INFO - 'USER': 'cltbld', 12:58:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:58:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:58:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:45 INFO - 'XPC_FLAGS': '0x0', 12:58:45 INFO - 'XPC_SERVICE_NAME': '0', 12:58:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:58:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:58:46 INFO - Cleaning up... 12:58:46 INFO - Return code: 0 12:58:46 INFO - Running post-action listener: _resource_record_post_action 12:58:46 INFO - Running post-action listener: _start_resource_monitoring 12:58:46 INFO - Starting resource monitoring. 12:58:46 INFO - [mozharness: 2017-04-09 19:58:46.195176Z] Finished create-virtualenv step (success) 12:58:46 INFO - [mozharness: 2017-04-09 19:58:46.196201Z] Running install step. 12:58:46 INFO - Running pre-action listener: _resource_record_pre_action 12:58:46 INFO - Running main action method: install 12:58:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:58:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:58:46 INFO - Reading from file tmpfile_stdout 12:58:46 INFO - Detecting whether we're running mozinstall >=1.0... 12:58:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:58:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:58:46 INFO - Reading from file tmpfile_stdout 12:58:46 INFO - Output received: 12:58:46 INFO - Usage: mozinstall [options] installer 12:58:46 INFO - Options: 12:58:46 INFO - -h, --help show this help message and exit 12:58:46 INFO - -d DEST, --destination=DEST 12:58:46 INFO - Directory to install application into. [default: 12:58:46 INFO - "/builds/slave/test"] 12:58:46 INFO - --app=APP Application being installed. [default: firefox] 12:58:46 INFO - mkdir: /builds/slave/test/build/application 12:58:46 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'] 12:58:46 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 12:59:06 INFO - Reading from file tmpfile_stdout 12:59:06 INFO - Output received: 12:59:06 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:59:06 INFO - Running post-action listener: _resource_record_post_action 12:59:06 INFO - [mozharness: 2017-04-09 19:59:06.190613Z] Finished install step (success) 12:59:06 INFO - [mozharness: 2017-04-09 19:59:06.190755Z] Running run-tests step. 12:59:06 INFO - Running pre-action listener: _resource_record_pre_action 12:59:06 INFO - Running main action method: run_tests 12:59:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:59:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:59:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:59:06 INFO - 2017-04-09 12:59:06.206 screenresolution[1629:7972] starting screenresolution argv=screenresolution get 12:59:06 INFO - 2017-04-09 12:59:06.209 screenresolution[1629:7972] Display 0: 1600x1200x32@60 12:59:06 INFO - 2017-04-09 12:59:06.216 screenresolution[1630:7974] starting screenresolution argv=screenresolution list 12:59:06 INFO - Available Modes on Display 0 12:59:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:59:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:59:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:59:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:59:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:59:06 INFO - Intel Iris: 12:59:06 INFO - Chipset Model: Intel Iris 12:59:06 INFO - Type: GPU 12:59:06 INFO - Bus: Built-In 12:59:06 INFO - VRAM (Dynamic, Max): 1536 MB 12:59:06 INFO - Vendor: Intel (0x8086) 12:59:06 INFO - Device ID: 0x0a2e 12:59:06 INFO - Revision ID: 0x0009 12:59:06 INFO - Displays: 12:59:06 INFO - Display: 12:59:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:59:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:59:06 INFO - Display Serial Number: 1600x1200 60 12:59:06 INFO - Main Display: Yes 12:59:06 INFO - Mirror: Off 12:59:06 INFO - Online: Yes 12:59:06 INFO - Rotation: Supported 12:59:06 INFO - Return code: 0 12:59:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:59:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:59:06 INFO - Python 2.7.3 12:59:06 INFO - Return code: 0 12:59:06 INFO - grabbing minidump binary from tooltool 12:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:59:06 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 0x10e2b0d30>, '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 0x10e1d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2a5be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:59:06 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 12:59:06 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 12:59:06 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 12:59:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:59:06 INFO - Return code: 0 12:59:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:59:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:59:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:59:06 INFO - ENV: RUST_BACKTRACE is now 1 12:59:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:59:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:59:06 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/TCEdOkYOTe6xZGXsEyMtvA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0201', '--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 12:59:06 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/TCEdOkYOTe6xZGXsEyMtvA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0201 --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 12:59:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yXBjBQTVwL/Render', 12:59:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:59:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:59:06 INFO - 'HOME': '/Users/cltbld', 12:59:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:59:06 INFO - 'LOGNAME': 'cltbld', 12:59:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:59:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:06 INFO - 'MOZ_NO_REMOTE': '1', 12:59:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:59:06 INFO - 'NO_EM_RESTART': '1', 12:59:06 INFO - 'PAGER': '/bin/cat', 12:59:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:06 INFO - 'PWD': '/builds/slave/test', 12:59:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:59:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:59:06 INFO - 'RUST_BACKTRACE': '1', 12:59:06 INFO - 'SHELL': '/bin/bash', 12:59:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k0qadRKOjp/Listeners', 12:59:06 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 12:59:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:59:06 INFO - 'USER': 'cltbld', 12:59:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:59:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:06 INFO - 'XPC_FLAGS': '0x0', 12:59:06 INFO - 'XPC_SERVICE_NAME': '0', 12:59:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:59:06 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/TCEdOkYOTe6xZGXsEyMtvA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0201', '--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 12:59:06 INFO - mozversion application_buildid: 20170409113321 12:59:06 INFO - mozversion application_changeset: 60fe200cb8dbd21695eae5775bec9305a9c900b6 12:59:06 INFO - mozversion application_display_name: Nightly 12:59:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:59:06 INFO - mozversion application_name: Firefox 12:59:06 INFO - mozversion application_remotingname: firefox 12:59:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:59:06 INFO - mozversion application_vendor: Mozilla 12:59:06 INFO - mozversion application_version: 55.0a1 12:59:06 INFO - mozversion platform_buildid: 20170409113321 12:59:06 INFO - mozversion platform_changeset: 60fe200cb8dbd21695eae5775bec9305a9c900b6 12:59:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:59:06 INFO - mozversion platform_version: 55.0a1 12:59:06 INFO - using testdate: 1491767946 12:59:06 INFO - actual date: 1491767946 12:59:06 INFO - starting webserver on 'localhost:49242' 12:59:06 INFO - SUITE-START | Running 2 tests 12:59:06 INFO - TEST-START | dromaeo_css 12:59:06 INFO - operating with platform_type : mac_ 12:59:06 INFO - Initialising browser for dromaeo_css test... 12:59:06 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/tmpxaXvuC/profile http://localhost:49242/getInfo.html) 12:59:09 INFO - PID 1640 | __metrics Screen width/height:1600/1200 12:59:09 INFO - PID 1640 | colorDepth:24 12:59:09 INFO - PID 1640 | Browser inner width/height: 1024/689 12:59:09 INFO - PID 1640 | __metrics 12:59:09 INFO - PID 1640 | 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" 12:59:09 INFO - PID 1640 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:59:10 INFO - TEST-INFO | 1640: exit 0 12:59:10 INFO - Browser initialized. 12:59:10 INFO - Running cycle 1/1 for dromaeo_css test... 12:59:10 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/tmpxaXvuC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:59:23 INFO - PID 1643 | RSS: Main: 237137920 12:59:23 INFO - PID 1643 | 13:02:28 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 13:02:30 INFO - PID 1643 | RSS: Main: 425074688 13:02:30 INFO - PID 1643 | 13:04:13 INFO - PID 1643 | ************************* 13:04:13 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 13:04:13 INFO - PID 1643 | 13:04:13 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:04:13 INFO - PID 1643 | Full stack: 13:04:13 INFO - PID 1643 | ************************* 13:04:13 INFO - PID 1643 | ************************* 13:04:13 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 13:04:13 INFO - PID 1643 | 13:04:13 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:04:13 INFO - PID 1643 | Full stack: 13:04:13 INFO - PID 1643 | ************************* 13:04:13 INFO - PID 1643 | ************************* 13:04:13 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 13:04:13 INFO - PID 1643 | 13:04:13 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:04:13 INFO - PID 1643 | Full stack: 13:04:13 INFO - PID 1643 | ************************* 13:04:13 INFO - PID 1643 | ************************* 13:04:13 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 13:04:13 INFO - PID 1643 | 13:04:13 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:04:13 INFO - PID 1643 | Full stack: 13:04:13 INFO - PID 1643 | ************************* 13:05:32 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 13:05:33 INFO - PID 1643 | RSS: Main: 371363840 13:05:33 INFO - PID 1643 | 13:08:35 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 13:08:36 INFO - PID 1643 | RSS: Main: 327061504 13:08:36 INFO - PID 1643 | 13:11:38 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 13:11:39 INFO - PID 1643 | RSS: Main: 328728576 13:11:39 INFO - PID 1643 | 13:14:43 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 13:14:43 INFO - PID 1643 | RSS: Main: 341700608 13:14:43 INFO - PID 1643 | 13:17:46 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 13:17:46 INFO - PID 1643 | RSS: Main: 378183680 13:17:46 INFO - PID 1643 | 13:17:46 INFO - PID 1643 | __start_tp_report 13:17:46 INFO - PID 1643 | _x_x_mozilla_page_load 13:17:46 INFO - PID 1643 | _x_x_mozilla_page_load_details 13:17:46 INFO - PID 1643 | |i|pagename|runs| 13:17:46 INFO - PID 1643 | |0;dojo.html;3109.953350699739;3504.6845783879444;3509.473578963156;3542.592601850786;3545.273218990107;5069.569086627636;5954.761809527614;6088.330283668793;6189.7524099036045;6206.689665516723;6043.1539584458105;6080.209572755547;6096.024636058231;6114.266288045441;6127.601705889114;5252.949410117983;5264.473552644743;5288.524032837044;5297.496737809902;5367.624266301361;5376.220448035052;5380.381256155553;5385.757640906149;5388.43421440749;5393;5369.167778994262;5375.00562395958;5375.16684913839;5379.112446446351;5379.731013449332;5399.892002159954;5404.702741349224;5445.074337362618;5453.15476101201;5501.449855014506;5263.526282634543;5362.436944120889;5371;5373.140297552372;5404.91892621611;6131.417515336036;6148.84627884302;6158.9692051539905;6176.227971503562;6182.258129024501;6166.105914642397;6297.118403423525;6300.779472718478;6315.3684631536935;6318.304986451487;6476.773312934072;6598.076269322299;6602.438792702626;6605.405513503808;6616.172978377703;6205.8138255851945;6235.064740288993;6237.220347456568;6249.9062514062325;6253.562250642457;6508.446782023581;6584.9012264816065;6612.702428390734;6766.8646627068165;6781.6609169541325;6287.717052732638;6298.338674439118;6340.492760579143;6341.841453963595;6352.174217351715;6541.967290163614;6576.210854697467;6578.671066446658;6582.24304205013;6582.670866456658;6093.055576385667;6386.07401926718;6457.935420645827;6466.547341686037;6475;5708.31500219968;6287.339829317947;6287.49700023997;6291.339409362043;6316.684165791692;4534.727916325031;5206.01085793698;5262.210668399694;5299.152135658276;5304.389995150607;4599.816007359668;4630.027694184192;4660.487346391894;4670.1126785910565;4677.181493238738;6205.22434695663;6220.34686357935;6220.657863817443;6221.906671399933;6229.56393052482;6279.340669229665;6363.7772677956045;6374.394432528902;6380.202474690664;6386.680665966683;6145.494353883238;6169.722362493699;6185.288691800411;6208.72060757258;6213.813585592439;5751.1085781703905;5767.740451679684;5786.623869448473;5790.565707571865;5814.738336774855;6703.759804436195;6734.494912881553;6746.089277947414;6751.088603038527;6759.155105611799;6273.372662733873;6355.3326900674765;6361.2048493938255;6362.840928976628;6372.9362706374195;6555.573887697285;6696.497762667722;6747.662616869039;6748.257691654012;6779.762708305383;6411.935880641134;6480.805575832733;6498.025296205418;6500.674966251763;6506.902396463962;6458.031295305742;6570.310117437601;6573.3426657333885;6584.374484423972;6620.3710647488415;6016.42843929826;6181.505479561714;6244.906326405016;6283.842903927439;6365.236171659245;5861;6288.27684816252;6324.430801227912;6339.366063393623;6351.396617321532;6198.969005154945;6262.966610509215;6264.404881536247;6272.749090036347;6285.842853928689;6205.441510264098;6223.128761973237;6242.687865606792;6251;6365.936340636535;6166.599171053867;6176.81469555914;6183.196184495987;6186.288576813724;6198.380161983946 13:17:46 INFO - PID 1643 | |1;ext.html;739.7595781371052;790.1466416270426;810.3193317613205;1118.5749415222215;1128.5090985421348;27584.724152758467;27928;27953.860230698818;28003.299917502074;28005.299867503323;27967.720322796766;38311.042223944416;38429.61570384295;38515;38526;8520.190581894725;8691.521966291852;8701.956490217572;8706.521141337224;8711.215990560848;8533.359998000144;8654.307655387554;8681.479111253346;8688.43525170865;8689.391742578022;6131.080337949321;6280.748770049193;8573.52845593492;8730.432521886058;8762.430442021248;8747.125287471266;8799.824003519925;8806.515641639708;8816.823663526759;8827.646894124227;8414.158584141536;8518.27594654455;8537.445066070748;8538.188872057144;8557.657693692245;25506.10728624508;25938.22185334443;25945.351366215808;26025.73974260252;36811.447828282595;3187.792793468417;3566.6789988901123;3609.981950090259;3611.9097022574383;3621.583517895423;30003.69996300031;30118.698813011808;30121.548176777367;30161.396772064654;30179.849100754574;3147.35479226758;3186.6654001329757;3188.617365916082;3213.453712868818;3221.114193596756;209745.9999999985;257917;258055.7097214502;258264;258270;47597.76201118972;47627.80838490974;47771.52228477671;47811.28283075757;47851.76074119607;47565.19478441717;47590.76204618955;47640;47653;47671;14306.141631502143;14413.567592972227;14420.567382978528;14428.206448645215;14495.057821241586;11759.235649682743;11781.234219775688;11796.351200684045;11804.58683946075;11805.586804461802;12355;12486.375681216085;12533.623991280276;12540.87459125397;12682.302473363869;4798.777076173015;4886.95113048865;4890.1931181355385;4892.19278818998;4908.460069392364;854.2695994924375;972.8617517504537;980.9013904427087;982.4400091947522;1034.3380236648552;22883.542329153657;23721.16975905835;23763.762362376154;23816.761832381453;23954.161604343764;932.3566738950103;1129.0121143999002;1132.1961407400838;1150.390293144618;1150.5673350157906;11376;12147.149699520949;12156.574519891761;12174.424634039371;12183.4332777625;310934;311114;311286;311462;311729;42814.57185428168;51706.48293517092;51843.740781295855;52100.21849672258;52140.47859521432;1498.168516473346;1528.8700460460764;1541.52212814028;1543.4443600303882;1552.2394026926725;19933.800661993195;23449.882750586137;23637;23695.52608947846;23716.169934052225;37696.05759855916;37713;37756.43365349577;37770.62229377781;38019.04952376213;281773;283400;283603;283627;283816;34167.97496075122;34224.486632700035;34254;34265.48601771025;34275.485867711504;42374.152516948874;42792;42958;43007.13985720331;43086;28327.29181770472;29184;29323.560146597392;30135.04122232048;30271.545926810675;29336.26659333534;29507.85246073756;29596.556051659674;29882.70117298886;30147.944821932004;35357.469637954935;36006.45990310095;36041.459378109874;36064.63935360613;36089.45865811963;29449.85275073611;29788.702112978594;30147.69852301449;30282;30297.697023029486;19563.413097607096;21854.235101771363;23319.650205247275;23796;24862.12982545602 13:17:46 INFO - PID 1643 | |2;jquery.html;385.5240655984027;437.1639115714001;438.5986822057817;444.24256642424666;456.94288213973255;18499.53751156222;21067.47331316716;21357.57284854302;21943.122275108995;22132.778672213273;22616.321510354675;23350;23352.94911728972;23589.882050589767;23769.76230237697;6056.242969628796;6065.514758819284;6285.308616052231;6339.11252424661;6411.487081033506;3744.794036328001;6375.585586936834;6419.5506314558;6429.967850160766;6433.356664333576;3820.388737801952;3938.7833669148185;4030.375291829771;6402.583832050925;6408.455281301095;6164.9519581670775;6392.904106438407;6407.487401007931;6408.327125651809;6448.93551064488;5588.524975377098;5612.69130197839;5615.438456154393;5624.91562626561;5631.408702086263;28273.434531309464;28326.716732832614;28336.716632833613;28450.288742781388;28556.428871422457;2241.3724157236;2279.2364557873134;2281.5208806150727;2284.9657255141187;2285.5086156476436;16309.51071467858;16986.895851769594;17559.29762809486;17689.646207075788;17832.197551110232;2092.5710229402935;2146.5170336674278;2180.13884515617;2184.311941738363;2197.9340619781433;155807.88384232364;163613;165050.1747491255;166179;167937.1603142001;10746.677599672023;11316.71708207285;11811.645650630322;12338.753224935452;12576.11967162308;16357.427490037791;16370.644017976287;16479.505614831574;16494.67010659804;16508.42220522276;7563.810904727426;8938.955305223431;8999.82000359989;9109.27125829932;9193.402428842104;8641.913580864237;8678.609462574199;8686;8842.734717958472;8880.467171969573;6448.806535803933;7718.488087919983;7853.646585903648;7901;8075.757727268191;1976.7430234069766;1992.2728204205362;2135.7116789233255;2159.438545978057;2323.2101085630966;961.1829944547219;961.697065424389;968.8110818390487;1006.9798604027878;1009.2228983682523;18128.637427251382;21313.360599182048;21385.572288554144;21391.03740331689;21644.24245151412;951.9714408567615;975.7853272280087;981.8527220916919;1018.2464975917916;1019.261035749076;10971;11113.888861111447;11208.943955280172;11220.831687524693;11478.311301321948;654729;661972;737932;741820;751854;147390;156970.3029697021;160431.19784401002;162689;163690;1154.2151337090859;1231.6428235811513;1254.2599866078874;1257.9999999999816;1259.9433025513874;22190.67281880018;22390.313162420614;22681.092756289563;22778;22884;58048.034235891966;62484.75030499455;62824.68587657032;63717.681411592646;64825;88944.6658300113;90644;92190;93234.53382733042;93302;8672.132786721277;8736.606852691517;8916.375853690179;9014.864777028219;9289.86065209036;14020.929895350459;14214.786778198128;14615.050021748551;14674.972751907264;14708.55874323772;11680.240784348991;11860;12155.453004614637;12212.206206596542;12219.633410997685;11317.886821131684;11330.490127944428;11527.250728702607;11626.651200463999;11654.766904662029;12124.818127727915;12133;12235.204711693712;12432.316222607844;12539.24764514132;7745.302922736981;8360.749177524684;8578.356623253156;9054.773630659287;9065.68270110543;11803.350815705218;11914.821277680669;12275.508979641072;12294.446749896455;12466.252024878537 13:17:46 INFO - PID 1643 | |3;mootools.html;1357.1924704800642;1426.329625076214;1439.5465428390053;1446.3636000159922;1451.3251338127768;9660.227181825454;11566.942165289172;11569.479373428196;11581.826272605897;11589.65231043069;11591.536338546448;11659.00898423635;11988.040956723464;12064.638060858188;12069.818952715716;2163.2320526213243;2558.0663057983793;2559.9488010239784;2562.1801023672433;2568.4092658688514;2436.4517983453757;2475.900963961439;2478.9008439662393;2480.2063339731294;2480.5659009673327;2458.2870967419426;2558.155808583163;2560.4879024195143;2561.6541766861424;2562.654041704374;2476.7770900618852;2513.5098655762135;2539.377852426149;2542.1229675761833;2565.9992602884795;2487.7014758228947;2497.7002759668776;2512.522620702061;2516.471540976397;2519.433127546306;11166.888331116666;11240.437978101145;11989.340586267752;12091.637250882399;12117.636470905887;6557.245916719543;6830.146231721035;6831.521793474459;6832.795016149524;6837.521373503857;4065.7967101645095;4315.676324275661;4320.65434765218;4408.823647054114;4422.7346359218545;1232.5624403336776;1263.6019653809021;1309.332240557313;1310.1745900082983;1314.5464814638933;15033.624159396102;15520;15558.222088895624;16567.92308499956;16710.58223544409;4591.632669386441;5510.0632892408385;5755.884882302415;5759.510441612426;5772;12434.937825310815;12467.376631168405;12469.376531173404;12477.376131193403;12479.31363775001;6566.737330506726;6602.372774586406;6613.801585952429;6622.9006564901565;6653.201615806134;6095.878082438415;6105.145279660851;6162.198914141133;6219.533534984895;6252.999520076766;3953.469779341224;4053.054533823781;4087.46862907826;4092.058826469869;4124.8556300529335;1110.3781882145863;1277.9808302875465;1284.344984058137;1285.5243559882904;1300.668329575971;785;792.3061590592033;810.2707563193173;816.8039670479161;833.3916241143999;6198.101275315054;6209.379062093754;6432.195975503062;6468.5472016958365;6590.242122155918;577.6418620455345;593.6942474625571;599.6282304970946;812.622130709223;815.1603848036532;4323.83808095952;4399.978000109979;4524.8416305429155;4545.977270113628;4568;14851.554453366416;14972.850271497146;15536.300866461037;15539.84460155384;15580.220988950507;15144.621384465476;15282.770758438632;15418.922905385625;15444.227788610524;15449.150296733562;8597.785055373666;11122.777544449227;11188.720281992852;11193.49629266685;11215.271007384494;5772.7402266898935;7040.331168538981;7218.205997340393;7219.241979592067;7247.8550428990075;12463.314517701614;12557.560485383334;12694.428750706425;12754.936225318814;12795.42420591057;13831.585052448443;13908.51320203788;13953.953453490825;14156.787648185491;14201.644958875697;8718;8747.868781968404;8774.605142768718;8915.73252802417;8918.241949434112;10735.677929662123;10845.891541084804;10846.728831778953;10867.782644347228;10872.945635271773;9013.278937684838;9268.814623707352;9282.396644218104;9372.531373431437;9500.85748713756;9088.409253398508;9175.816483670424;9226;9255.722328329892;9338.066193380608;7156.248593897566;8206.179382061984;8402.327813775006;8431.747047588582;8436;5469.097598896296;6038.607490513103;6053.697315134314;6056.182415373868;6182.907256391248;5044.319016932667;5496.945030549803;6281.214848143982;6352.936470635234;6437.871242575216 13:17:46 INFO - PID 1643 | |4;prototype.html;372.33352299384103;396.1996766531606;396.8095314249162;397.87466947911406;411.7118017387829;5014.047331007111;5645.74594143263;5697.704037039064;5705.343885453174;5724.2558467399285;4520.005598768265;5210.9739451302785;5596.944030559694;5626.887462250763;5657.23627310313;3740.3828368319196;4440.689151759379;4460.30865215892;4488.416505854234;4497.70764900282;4437.778111094449;4446.799894004761;4448.755318457484;4470.418845550074;4539.455265368144;3545.592256890452;4349.41282926804;4424.955750442503;4481.7983190756495;4487.483939346984;4394.60448559628;4423.60187583119;4431.202383570956;4435.733855968652;4439.733615983019;3905.882823515299;3912.902177445558;3916.746641074857;3950.7036972227197;3985.461962635065;4711.24620060792;5407.648502847342;5570.693611851347;5601.495865372136;5686.289213848269;4476.485204201494;4511.548845115495;5083.669561478492;5362.731863406814;5368.194770784375;5383.892322153574;6196.8760624787255;6196.907046394308;6216.2851272103835;6232.345603711636;3983.322835118008;4116.91766164675;4193.685473589493;4471.642268618502;4496.685232033759;5284.81503147388;6004.778232054168;6117.021276595768;6313.715882785285;6322.241331040213;4180.6446452051305;4267.615914567704;4280.850170244026;4295.140971805651;4318.330658747836;3972.066564357374;4134.524529679125;4324.589164029412;4334.761588112684;4342.58986262621;4580.312953057001;4689.5848637951485;4773;4782.282657601388;4877.609791216694;6043.7884674036195;6044.788432404845;6067.757289708362;6074.969625151934;6091.725872335755;1396.9161850289015;1444.443889102682;1458.6863824277832;1475.5425817996456;1481.3111902965172;963.3689933093834;991.2417000994245;996.4270544436832;998.2912132385942;1000.1248907206194;4852.611791056707;5772.018756811352;5790.073588225863;5794.420557944172;5828.5120457247685;4959.776810043557;6147.415995480422;6252.249730032425;6269.937300626935;6310.873782524323;5711.514521265656;5736.196932429463;5738.282714660668;5743.4543718346695;5751.252337196138;2750.5049091163382;3040.619922509686;3270.721988630993;3284.6350627548127;3296.901092967215;6419.903701444482;6426.839329016719;6441.935580644227;6447.2263328400895;6455.903161452582;6094.257048438488;6226.688665566703;6446.580972236789;6458.38645328693;6537.215534135934;5460.334597947664;6395.744170233232;6455.483561315177;6471.2759685428955;6511.609303441809;6084.452399284086;6158.69049106585;6203.852287326859;6305.4009869062365;6319.58922670025;5067.645264831426;5411.810586629449;5854.736536855767;6008.339082700987;6039.516838652809;5774.624649397776;5797.76808927655;6334.809955701337;6355.5551111421755;6374.1394911688185;3313.3042061167425;4097.930545074718;4156.667466602604;4202.2435961526;4228.492580890313;5761.683107429131;5832.883342333214;5884.617114978062;6045;6332.810015699536;4868.95131048685;6017.458428741435;6122.4795892347865;6148.846278843064;6156.938430615815;4855.927161092657;5160.845174644766;6089.5737298388685;6097.237845269341;6109.389061093855;4866.90266194667;5396.227734193562;5564.85920386328;5717.342505611741;5760.913586296293;4851.587615052619;6046.213992181164;6050.30421501533;6059.454649081604;6113.57204995646;4774.16194765011;4914.262860570943;5636.267285252891;5930.229070220844;5995.910061348996 13:17:46 INFO - PID 1643 | |5;yui.html;708.3023222126208;849.2738708404314;860.0281681699679;863.145485968891;876.7413612984169;13247.403866825993;17945.01302428366;18689.34587289445;18709.34517291895;18736.531586710338;16797.42546748354;17099.31602735892;17182.484525464257;17220;17238.310467581312;954.1984732824409;962.3552220012573;986.4919566423262;987.4568987057125;987.7876256604828;676.0974099577071;695.6417445015821;949.8195342884829;984.07988530724;996.9102780749731;1035.5236591168073;1036.4040676610941;1039.0648416425202;1039.0907955538903;1052.1372474570856;1030.7526193713454;1032.3496197395593;1033.8707661542308;1035.0012238190106;1041.7760181560964;762.0436352377731;764.6024067484876;768.4352001279055;769.2115581528922;772.3628006894335;16239.51281461558;16504.66990660192;16571.42000030005;16737.497875063767;16765.66468670632;16782.160891955355;16829.83170168295;17063.061531615756;17222.827771722248;17243.568910777205;13836.377363018688;13943.023988320821;13963.720725585432;13965.231912244823;14189.935754818327;3403.7277017838514;3426.126337783849;3426.400379933502;3430.9485357719655;3432.4508078707536;107704.4614776929;108289;108302.91697083008;108339;108397.37403938947;11282.605108821152;11653.30080195174;12300.81548776769;13198.538051168354;13569.728605427836;18799.718004229948;19808.108635111454;20550.69173962392;25230;25328;7968.203179682101;8761.737147885573;8798;9040.502772347452;9046.773830654154;4779.091972525209;4874.171390863562;4874.4150701916;4876.317315575822;4876.780544875489;4278.272693642026;4309.633681137138;4382.912341753211;4405.7797110144365;4414.470263568328;885.5527958381106;899.7480705402497;959.6161535385762;967.0184762466102;969.2778879734643;642.5277421095491;668.7893313606198;672.028918213187;678.0778141727247;702.3187508117118;11469.770604587862;11668.289759532516;11900.166988310735;12070.396480175956;12311.938440307742;639.0350570638277;657.3722095398882;659.5679829711546;690.3441730356082;699.2448155991517;4904.2643603459055;4926.507349265116;5594.356648985337;5659.094544872801;5688.431156884279;84362;103933.48033259786;105206.47396762967;105628;105793.47103264435;91478.54260728654;92854.07145928455;93209.40743555408;93506.38961662322;97245;81688;81979.36041279142;84344.15655843363;84435;84920.72618910721;10424.791504170025;10492.842607361048;10807.35155890649;10908.290961087503;11075.169362297698;36691.44962825506;38491.8452446427;38768.80615596904;39078.413823793235;39782;50090.74954625204;52988.4701152999;64690.67654661697;67680;69526.65236673785;16494.83505164933;16684.749728753835;16733.665326693153;16758.82688211862;16978.49064528066;18282.268709251483;18410.90794546019;18528;18603.81396186075;18669.626607468046;16713.5821604456;16749.74875376895;17189.742153867952;17232;17349.132543373034;16367.263473143976;16767.413140540022;16868.57828554296;17156.656866862842;17226;16169.59576010609;16908;16934.40729574459;16958.236879340213;17194.570135746206;9826.705198844045;10654.414007229676;11469.598564050219;11720.296782193096;12153.392330383622;10628.309159904582;11986.381838451698;13916.930415347859;13937.445951282358;14030.719385612027 13:17:46 INFO - PID 1643 | __end_tp_report 13:17:46 INFO - PID 1643 | __start_cc_report 13:17:46 INFO - PID 1643 | _x_x_mozilla_cycle_collect,2093 13:17:46 INFO - PID 1643 | __end_cc_report 13:17:46 INFO - PID 1643 | __startTimestamp1491769066502__endTimestamp 13:17:46 INFO - PID 1643 | 13:17:46 INFO - PID 1643 | ------- Summary: start ------- 13:17:46 INFO - PID 1643 | Number of tests: 6 13:17:46 INFO - PID 1643 | 13:17:46 INFO - PID 1643 | [#0] dojo.html Cycles:165 Average:5998.01 Median:6221.91 stddev:684.76 (11.0%) stddev-sans-first:648.30 13:17:46 INFO - PID 1643 | Values: 3110.0 3504.7 3509.5 3542.6 3545.3 5069.6 5954.8 6088.3 6189.8 6206.7 6043.2 6080.2 6096.0 6114.3 6127.6 5252.9 5264.5 5288.5 5297.5 5367.6 5376.2 5380.4 5385.8 5388.4 5393.0 5369.2 5375.0 5375.2 5379.1 5379.7 5399.9 5404.7 5445.1 5453.2 5501.4 5263.5 5362.4 5371.0 5373.1 5404.9 6131.4 6148.8 6159.0 6176.2 6182.3 6166.1 6297.1 6300.8 6315.4 6318.3 6476.8 6598.1 6602.4 6605.4 6616.2 6205.8 6235.1 6237.2 6249.9 6253.6 6508.4 6584.9 6612.7 6766.9 6781.7 6287.7 6298.3 6340.5 6341.8 6352.2 6542.0 6576.2 6578.7 6582.2 6582.7 6093.1 6386.1 6457.9 6466.5 6475.0 5708.3 6287.3 6287.5 6291.3 6316.7 4534.7 5206.0 5262.2 5299.2 5304.4 4599.8 4630.0 4660.5 4670.1 4677.2 6205.2 6220.3 6220.7 6221.9 6229.6 6279.3 6363.8 6374.4 6380.2 6386.7 6145.5 6169.7 6185.3 6208.7 6213.8 5751.1 5767.7 5786.6 5790.6 5814.7 6703.8 6734.5 6746.1 6751.1 6759.2 6273.4 6355.3 6361.2 6362.8 6372.9 6555.6 6696.5 6747.7 6748.3 6779.8 6411.9 6480.8 6498.0 6500.7 6506.9 6458.0 6570.3 6573.3 6584.4 6620.4 6016.4 6181.5 6244.9 6283.8 6365.2 5861.0 6288.3 6324.4 6339.4 6351.4 6199.0 6263.0 6264.4 6272.7 6285.8 6205.4 6223.1 6242.7 6251.0 6365.9 6166.6 6176.8 6183.2 6186.3 6198.4 13:17:46 INFO - PID 1643 | 13:17:46 INFO - PID 1643 | [#1] ext.html Cycles:180 Average:42476.41 Median:311595.50 stddev:74035.09 (23.8%) stddev-sans-first:74176.46 13:17:46 INFO - PID 1643 | Values: 739.8 790.1 810.3 1118.6 1128.5 27584.7 27928.0 27953.9 28003.3 28005.3 27967.7 38311.0 38429.6 38515.0 38526.0 8520.2 8691.5 8702.0 8706.5 8711.2 8533.4 8654.3 8681.5 8688.4 8689.4 6131.1 6280.7 8573.5 8730.4 8762.4 8747.1 8799.8 8806.5 8816.8 8827.6 8414.2 8518.3 8537.4 8538.2 8557.7 25506.1 25938.2 25945.4 26025.7 36811.4 3187.8 3566.7 3610.0 3611.9 3621.6 30003.7 30118.7 30121.5 30161.4 30179.8 3147.4 3186.7 3188.6 3213.5 3221.1 209746.0 257917.0 258055.7 258264.0 258270.0 47597.8 47627.8 47771.5 47811.3 47851.8 47565.2 47590.8 47640.0 47653.0 47671.0 14306.1 14413.6 14420.6 14428.2 14495.1 11759.2 11781.2 11796.4 11804.6 11805.6 12355.0 12486.4 12533.6 12540.9 12682.3 4798.8 4887.0 4890.2 4892.2 4908.5 854.3 972.9 980.9 982.4 1034.3 22883.5 23721.2 23763.8 23816.8 23954.2 932.4 1129.0 1132.2 1150.4 1150.6 11376.0 12147.1 12156.6 12174.4 12183.4 310934.0 311114.0 311286.0 311462.0 311729.0 42814.6 51706.5 51843.7 52100.2 52140.5 1498.2 1528.9 1541.5 1543.4 1552.2 19933.8 23449.9 23637.0 23695.5 23716.2 37696.1 37713.0 37756.4 37770.6 38019.0 281773.0 283400.0 283603.0 283627.0 283816.0 34168.0 34224.5 34254.0 34265.5 34275.5 42374.2 42792.0 42958.0 43007.1 43086.0 28327.3 29184.0 29323.6 30135.0 30271.5 29336.3 29507.9 29596.6 29882.7 30147.9 35357.5 36006.5 36041.5 36064.6 36089.5 29449.9 29788.7 30147.7 30282.0 30297.7 19563.4 21854.2 23319.7 23796.0 24862.1 13:17:46 INFO - PID 1643 | 13:17:46 INFO - PID 1643 | [#2] jquery.html Cycles:180 Average:41739.22 Median:2283.24 stddev:119564.79 (5236.6%) stddev-sans-first:119859.88 13:17:46 INFO - PID 1643 | Values: 385.5 437.2 438.6 444.2 456.9 18499.5 21067.5 21357.6 21943.1 22132.8 22616.3 23350.0 23352.9 23589.9 23769.8 6056.2 6065.5 6285.3 6339.1 6411.5 3744.8 6375.6 6419.6 6430.0 6433.4 3820.4 3938.8 4030.4 6402.6 6408.5 6165.0 6392.9 6407.5 6408.3 6448.9 5588.5 5612.7 5615.4 5624.9 5631.4 28273.4 28326.7 28336.7 28450.3 28556.4 2241.4 2279.2 2281.5 2285.0 2285.5 16309.5 16986.9 17559.3 17689.6 17832.2 2092.6 2146.5 2180.1 2184.3 2197.9 155807.9 163613.0 165050.2 166179.0 167937.2 10746.7 11316.7 11811.6 12338.8 12576.1 16357.4 16370.6 16479.5 16494.7 16508.4 7563.8 8939.0 8999.8 9109.3 9193.4 8641.9 8678.6 8686.0 8842.7 8880.5 6448.8 7718.5 7853.6 7901.0 8075.8 1976.7 1992.3 2135.7 2159.4 2323.2 961.2 961.7 968.8 1007.0 1009.2 18128.6 21313.4 21385.6 21391.0 21644.2 952.0 975.8 981.9 1018.2 1019.3 10971.0 11113.9 11208.9 11220.8 11478.3 654729.0 661972.0 737932.0 741820.0 751854.0 147390.0 156970.3 160431.2 162689.0 163690.0 1154.2 1231.6 1254.3 1258.0 1259.9 22190.7 22390.3 22681.1 22778.0 22884.0 58048.0 62484.8 62824.7 63717.7 64825.0 88944.7 90644.0 92190.0 93234.5 93302.0 8672.1 8736.6 8916.4 9014.9 9289.9 14020.9 14214.8 14615.1 14675.0 14708.6 11680.2 11860.0 12155.5 12212.2 12219.6 11317.9 11330.5 11527.3 11626.7 11654.8 12124.8 12133.0 12235.2 12432.3 12539.2 7745.3 8360.7 8578.4 9054.8 9065.7 11803.4 11914.8 12275.5 12294.4 12466.3 13:17:46 INFO - PID 1643 | 13:17:46 INFO - PID 1643 | [#3] mootools.html Cycles:180 Average:7177.75 Median:2564.33 stddev:4551.37 (177.5%) stddev-sans-first:4543.13 13:17:46 INFO - PID 1643 | Values: 1357.2 1426.3 1439.5 1446.4 1451.3 9660.2 11566.9 11569.5 11581.8 11589.7 11591.5 11659.0 11988.0 12064.6 12069.8 2163.2 2558.1 2559.9 2562.2 2568.4 2436.5 2475.9 2478.9 2480.2 2480.6 2458.3 2558.2 2560.5 2561.7 2562.7 2476.8 2513.5 2539.4 2542.1 2566.0 2487.7 2497.7 2512.5 2516.5 2519.4 11166.9 11240.4 11989.3 12091.6 12117.6 6557.2 6830.1 6831.5 6832.8 6837.5 4065.8 4315.7 4320.7 4408.8 4422.7 1232.6 1263.6 1309.3 1310.2 1314.5 15033.6 15520.0 15558.2 16567.9 16710.6 4591.6 5510.1 5755.9 5759.5 5772.0 12434.9 12467.4 12469.4 12477.4 12479.3 6566.7 6602.4 6613.8 6622.9 6653.2 6095.9 6105.1 6162.2 6219.5 6253.0 3953.5 4053.1 4087.5 4092.1 4124.9 1110.4 1278.0 1284.3 1285.5 1300.7 785.0 792.3 810.3 816.8 833.4 6198.1 6209.4 6432.2 6468.5 6590.2 577.6 593.7 599.6 812.6 815.2 4323.8 4400.0 4524.8 4546.0 4568.0 14851.6 14972.9 15536.3 15539.8 15580.2 15144.6 15282.8 15418.9 15444.2 15449.2 8597.8 11122.8 11188.7 11193.5 11215.3 5772.7 7040.3 7218.2 7219.2 7247.9 12463.3 12557.6 12694.4 12754.9 12795.4 13831.6 13908.5 13954.0 14156.8 14201.6 8718.0 8747.9 8774.6 8915.7 8918.2 10735.7 10845.9 10846.7 10867.8 10872.9 9013.3 9268.8 9282.4 9372.5 9500.9 9088.4 9175.8 9226.0 9255.7 9338.1 7156.2 8206.2 8402.3 8431.7 8436.0 5469.1 6038.6 6053.7 6056.2 6182.9 5044.3 5496.9 6281.2 6352.9 6437.9 13:17:46 INFO - PID 1643 | 13:17:46 INFO - PID 1643 | [#4] prototype.html Cycles:180 Average:4912.38 Median:5512.60 stddev:1490.29 (27.0%) stddev-sans-first:1454.99 13:17:46 INFO - PID 1643 | Values: 372.3 396.2 396.8 397.9 411.7 5014.0 5645.7 5697.7 5705.3 5724.3 4520.0 5211.0 5596.9 5626.9 5657.2 3740.4 4440.7 4460.3 4488.4 4497.7 4437.8 4446.8 4448.8 4470.4 4539.5 3545.6 4349.4 4425.0 4481.8 4487.5 4394.6 4423.6 4431.2 4435.7 4439.7 3905.9 3912.9 3916.7 3950.7 3985.5 4711.2 5407.6 5570.7 5601.5 5686.3 4476.5 4511.5 5083.7 5362.7 5368.2 5383.9 6196.9 6196.9 6216.3 6232.3 3983.3 4116.9 4193.7 4471.6 4496.7 5284.8 6004.8 6117.0 6313.7 6322.2 4180.6 4267.6 4280.9 4295.1 4318.3 3972.1 4134.5 4324.6 4334.8 4342.6 4580.3 4689.6 4773.0 4782.3 4877.6 6043.8 6044.8 6067.8 6075.0 6091.7 1396.9 1444.4 1458.7 1475.5 1481.3 963.4 991.2 996.4 998.3 1000.1 4852.6 5772.0 5790.1 5794.4 5828.5 4959.8 6147.4 6252.2 6269.9 6310.9 5711.5 5736.2 5738.3 5743.5 5751.3 2750.5 3040.6 3270.7 3284.6 3296.9 6419.9 6426.8 6441.9 6447.2 6455.9 6094.3 6226.7 6446.6 6458.4 6537.2 5460.3 6395.7 6455.5 6471.3 6511.6 6084.5 6158.7 6203.9 6305.4 6319.6 5067.6 5411.8 5854.7 6008.3 6039.5 5774.6 5797.8 6334.8 6355.6 6374.1 3313.3 4097.9 4156.7 4202.2 4228.5 5761.7 5832.9 5884.6 6045.0 6332.8 4869.0 6017.5 6122.5 6148.8 6156.9 4855.9 5160.8 6089.6 6097.2 6109.4 4866.9 5396.2 5564.9 5717.3 5760.9 4851.6 6046.2 6050.3 6059.5 6113.6 4774.2 4914.3 5636.3 5930.2 5995.9 13:17:46 INFO - PID 1643 | 13:17:46 INFO - PID 1643 | [#5] yui.html Cycles:180 Average:21376.42 Median:18699.35 stddev:29305.92 (156.7%) stddev-sans-first:29347.04 13:17:46 INFO - PID 1643 | Values: 708.3 849.3 860.0 863.1 876.7 13247.4 17945.0 18689.3 18709.3 18736.5 16797.4 17099.3 17182.5 17220.0 17238.3 954.2 962.4 986.5 987.5 987.8 676.1 695.6 949.8 984.1 996.9 1035.5 1036.4 1039.1 1039.1 1052.1 1030.8 1032.3 1033.9 1035.0 1041.8 762.0 764.6 768.4 769.2 772.4 16239.5 16504.7 16571.4 16737.5 16765.7 16782.2 16829.8 17063.1 17222.8 17243.6 13836.4 13943.0 13963.7 13965.2 14189.9 3403.7 3426.1 3426.4 3430.9 3432.5 107704.5 108289.0 108302.9 108339.0 108397.4 11282.6 11653.3 12300.8 13198.5 13569.7 18799.7 19808.1 20550.7 25230.0 25328.0 7968.2 8761.7 8798.0 9040.5 9046.8 4779.1 4874.2 4874.4 4876.3 4876.8 4278.3 4309.6 4382.9 4405.8 4414.5 885.6 899.7 959.6 967.0 969.3 642.5 668.8 672.0 678.1 702.3 11469.8 11668.3 11900.2 12070.4 12311.9 639.0 657.4 659.6 690.3 699.2 4904.3 4926.5 5594.4 5659.1 5688.4 84362.0 103933.5 105206.5 105628.0 105793.5 91478.5 92854.1 93209.4 93506.4 97245.0 81688.0 81979.4 84344.2 84435.0 84920.7 10424.8 10492.8 10807.4 10908.3 11075.2 36691.4 38491.8 38768.8 39078.4 39782.0 50090.7 52988.5 64690.7 67680.0 69526.7 16494.8 16684.7 16733.7 16758.8 16978.5 18282.3 18410.9 18528.0 18603.8 18669.6 16713.6 16749.7 17189.7 17232.0 17349.1 16367.3 16767.4 16868.6 17156.7 17226.0 16169.6 16908.0 16934.4 16958.2 17194.6 9826.7 10654.4 11469.6 11720.3 12153.4 10628.3 11986.4 13916.9 13937.4 14030.7 13:17:46 INFO - PID 1643 | -------- Summary: end -------- 13:17:46 INFO - PID 1643 | 13:17:47 INFO - TEST-INFO | 1643: exit 0 13:17:47 INFO - TEST-OK | dromaeo_css | took 1120368ms 13:17:47 INFO - TEST-START | kraken 13:17:47 INFO - operating with platform_type : mac_ 13:17:47 INFO - Initialising browser for kraken test... 13:17:47 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/tmpobEoha/profile http://localhost:49242/getInfo.html) 13:17:49 INFO - PID 1648 | __metrics Screen width/height:1600/1200 13:17:49 INFO - PID 1648 | colorDepth:24 13:17:49 INFO - PID 1648 | Browser inner width/height: 1024/689 13:17:49 INFO - PID 1648 | __metrics 13:17:49 INFO - PID 1648 | 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" 13:17:49 INFO - PID 1648 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:17:50 INFO - TEST-INFO | 1648: exit 0 13:17:50 INFO - Browser initialized. 13:17:50 INFO - Running cycle 1/1 for kraken test... 13:17:50 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/tmpobEoha/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:18:03 INFO - PID 1649 | RSS: Main: 238186496 13:18:03 INFO - PID 1649 | 13:18:06 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 13:18:07 INFO - PID 1649 | RSS: Main: 292196352 13:18:07 INFO - PID 1649 | 13:18:10 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 13:18:10 INFO - PID 1649 | RSS: Main: 292536320 13:18:10 INFO - PID 1649 | 13:18:14 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 13:18:15 INFO - PID 1649 | RSS: Main: 388579328 13:18:15 INFO - PID 1649 | 13:18:17 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 13:18:17 INFO - PID 1649 | RSS: Main: 288604160 13:18:17 INFO - PID 1649 | 13:18:19 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:18:20 INFO - PID 1649 | RSS: Main: 291217408 13:18:20 INFO - PID 1649 | 13:18:23 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 13:18:24 INFO - PID 1649 | RSS: Main: 332058624 13:18:24 INFO - PID 1649 | 13:18:27 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 13:18:28 INFO - PID 1649 | RSS: Main: 344629248 13:18:28 INFO - PID 1649 | 13:18:31 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 13:18:32 INFO - PID 1649 | RSS: Main: 347803648 13:18:32 INFO - PID 1649 | 13:18:33 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:18:34 INFO - PID 1649 | RSS: Main: 309469184 13:18:34 INFO - PID 1649 | 13:18:36 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:18:36 INFO - PID 1649 | RSS: Main: 313368576 13:18:36 INFO - PID 1649 | 13:18:39 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:18:39 INFO - PID 1649 | RSS: Main: 315551744 13:18:39 INFO - PID 1649 | 13:18:42 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:18:43 INFO - PID 1649 | RSS: Main: 331063296 13:18:43 INFO - PID 1649 | 13:18:47 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:18:47 INFO - PID 1649 | RSS: Main: 314515456 13:18:47 INFO - PID 1649 | 13:18:49 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 13:18:50 INFO - PID 1649 | RSS: Main: 381276160 13:18:50 INFO - PID 1649 | 13:18:50 INFO - PID 1649 | __start_tp_report 13:18:50 INFO - PID 1649 | _x_x_mozilla_page_load 13:18:50 INFO - PID 1649 | _x_x_mozilla_page_load_details 13:18:50 INFO - PID 1649 | |i|pagename|runs| 13:18:50 INFO - PID 1649 | |0;ai-astar;153;102;169;102;182;178;176;122;121;123 13:18:50 INFO - PID 1649 | |1;audio-beat-detection;191;121;117;155;111;146;148;149;143;118 13:18:50 INFO - PID 1649 | |2;audio-dft;214;214;208;207;206;217;209;208;219;219 13:18:50 INFO - PID 1649 | |3;audio-fft;83;64;66;99;69;64;61;64;80;66 13:18:50 INFO - PID 1649 | |4;audio-oscillator;97;77;94;76;74;73;94;74;74;92 13:18:50 INFO - PID 1649 | |5;imaging-gaussian-blur;90;92;92;91;91;92;97;138;90;91 13:18:50 INFO - PID 1649 | |6;imaging-darkroom;98;99;102;101;99;100;103;156;156;100 13:18:50 INFO - PID 1649 | |7;imaging-desaturate;101;132;164;102;101;101;101;99;100;102 13:18:50 INFO - PID 1649 | |8;json-parse-financial;52;52;51;53;52;54;53;53;53;52 13:18:50 INFO - PID 1649 | |9;json-stringify-tinderbox;58;71;68;70;66;63;64;64;66;66 13:18:50 INFO - PID 1649 | |10;stanford-crypto-aes;90;90;91;95;111;116;117;92;90;91 13:18:50 INFO - PID 1649 | |11;stanford-crypto-ccm;152;151;163;162;168;139;170;148;201;154 13:18:50 INFO - PID 1649 | |12;stanford-crypto-pbkdf2;202;255;212;199;203;204;200;203;234;185 13:18:50 INFO - PID 1649 | |13;stanford-crypto-sha256-iterative;77;65;91;108;99;102;95;73;75;75 13:18:50 INFO - PID 1649 | __end_tp_report 13:18:50 INFO - PID 1649 | __start_cc_report 13:18:50 INFO - PID 1649 | _x_x_mozilla_cycle_collect,2150 13:18:50 INFO - PID 1649 | __end_cc_report 13:18:50 INFO - PID 1649 | __startTimestamp1491769130097__endTimestamp 13:18:50 INFO - PID 1649 | 13:18:50 INFO - PID 1649 | ------- Summary: start ------- 13:18:50 INFO - PID 1649 | Number of tests: 14 13:18:50 INFO - PID 1649 | 13:18:50 INFO - PID 1649 | [#0] ai-astar Cycles:10 Average:142.80 Median:161.00 stddev:32.14 (20.0%) stddev-sans-first:33.88 13:18:50 INFO - PID 1649 | Values: 153.0 102.0 169.0 102.0 182.0 178.0 176.0 122.0 121.0 123.0 13:18:50 INFO - PID 1649 | 13:18:50 INFO - PID 1649 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:147.00 stddev:24.11 (16.4%) stddev-sans-first:17.06 13:18:50 INFO - PID 1649 | Values: 191.0 121.0 117.0 155.0 111.0 146.0 148.0 149.0 143.0 118.0 13:18:50 INFO - PID 1649 | 13:18:50 INFO - PID 1649 | [#2] audio-dft Cycles:10 Average:212.10 Median:214.00 stddev:5.09 (2.4%) stddev-sans-first:5.35 13:18:50 INFO - PID 1649 | Values: 214.0 214.0 208.0 207.0 206.0 217.0 209.0 208.0 219.0 219.0 13:18:50 INFO - PID 1649 | 13:18:50 INFO - PID 1649 | [#3] audio-fft Cycles:10 Average:71.60 Median:67.50 stddev:12.05 (17.8%) stddev-sans-first:12.05 13:18:50 INFO - PID 1649 | Values: 83.0 64.0 66.0 99.0 69.0 64.0 61.0 64.0 80.0 66.0 13:18:50 INFO - PID 1649 | 13:18:50 INFO - PID 1649 | [#4] audio-oscillator Cycles:10 Average:82.50 Median:84.50 stddev:10.24 (12.1%) stddev-sans-first:9.43 13:18:50 INFO - PID 1649 | Values: 97.0 77.0 94.0 76.0 74.0 73.0 94.0 74.0 74.0 92.0 13:18:50 INFO - PID 1649 | 13:18:50 INFO - PID 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:96.40 Median:91.50 stddev:14.75 (16.1%) stddev-sans-first:15.46 13:18:50 INFO - PID 1649 | Values: 90.0 92.0 92.0 91.0 91.0 92.0 97.0 138.0 90.0 91.0 13:18:50 INFO - PID 1649 | 13:18:50 INFO - PID 1649 | [#6] imaging-darkroom Cycles:10 Average:111.40 Median:156.00 stddev:23.55 (15.1%) stddev-sans-first:24.48 13:18:50 INFO - PID 1649 | Values: 98.0 99.0 102.0 101.0 99.0 100.0 103.0 156.0 156.0 100.0 13:18:50 INFO - PID 1649 | 13:18:50 INFO - PID 1649 | [#7] imaging-desaturate Cycles:10 Average:110.30 Median:102.00 stddev:21.27 (20.9%) stddev-sans-first:22.29 13:18:50 INFO - PID 1649 | Values: 101.0 132.0 164.0 102.0 101.0 101.0 101.0 99.0 100.0 102.0 13:18:50 INFO - PID 1649 | 13:18:50 INFO - PID 1649 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:53.00 stddev:0.85 (1.6%) stddev-sans-first:0.88 13:18:50 INFO - PID 1649 | Values: 52.0 52.0 51.0 53.0 52.0 54.0 53.0 53.0 53.0 52.0 13:18:50 INFO - PID 1649 | 13:18:50 INFO - PID 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:3.72 (5.6%) stddev-sans-first:2.74 13:18:50 INFO - PID 1649 | Values: 58.0 71.0 68.0 70.0 66.0 63.0 64.0 64.0 66.0 66.0 13:18:50 INFO - PID 1649 | 13:18:50 INFO - PID 1649 | [#10] stanford-crypto-aes Cycles:10 Average:98.30 Median:90.50 stddev:11.49 (12.7%) stddev-sans-first:11.79 13:18:50 INFO - PID 1649 | Values: 90.0 90.0 91.0 95.0 111.0 116.0 117.0 92.0 90.0 91.0 13:18:50 INFO - PID 1649 | 13:18:50 INFO - PID 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:160.80 Median:162.50 stddev:17.05 (10.5%) stddev-sans-first:17.79 13:18:50 INFO - PID 1649 | Values: 152.0 151.0 163.0 162.0 168.0 139.0 170.0 148.0 201.0 154.0 13:18:50 INFO - PID 1649 | 13:18:50 INFO - PID 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:209.70 Median:203.50 stddev:20.13 (9.9%) stddev-sans-first:21.16 13:18:50 INFO - PID 1649 | Values: 202.0 255.0 212.0 199.0 203.0 204.0 200.0 203.0 234.0 185.0 13:18:50 INFO - PID 1649 | 13:18:50 INFO - PID 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:86.00 Median:76.00 stddev:14.71 (19.4%) stddev-sans-first:15.24 13:18:50 INFO - PID 1649 | Values: 77.0 65.0 91.0 108.0 99.0 102.0 95.0 73.0 75.0 75.0 13:18:50 INFO - PID 1649 | -------- Summary: end -------- 13:18:50 INFO - PID 1649 | 13:18:51 INFO - TEST-INFO | 1649: exit 0 13:18:51 INFO - TEST-OK | kraken | took 63999ms 13:18:51 INFO - SUITE-END | took 1184s 13:18:51 INFO - Completed test suite (00:19:44) 13:18:51 INFO - javascript benchmark 13:18:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7736.032273568355, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3109.953350699739, 3504.6845783879444, 3509.473578963156, 3542.592601850786, 3545.273218990107, 5069.569086627636, 5954.761809527614, 6088.330283668793, 6189.7524099036045, 6206.689665516723, 6043.1539584458105, 6080.209572755547, 6096.024636058231, 6114.266288045441, 6127.601705889114, 5252.949410117983, 5264.473552644743, 5288.524032837044, 5297.496737809902, 5367.624266301361, 5376.220448035052, 5380.381256155553, 5385.757640906149, 5388.43421440749, 5393.0, 5369.167778994262, 5375.00562395958, 5375.16684913839, 5379.112446446351, 5379.731013449332, 5399.892002159954, 5404.702741349224, 5445.074337362618, 5453.15476101201, 5501.449855014506, 5263.526282634543, 5362.436944120889, 5371.0, 5373.140297552372, 5404.91892621611, 6131.417515336036, 6148.84627884302, 6158.9692051539905, 6176.227971503562, 6182.258129024501, 6166.105914642397, 6297.118403423525, 6300.779472718478, 6315.3684631536935, 6318.304986451487, 6476.773312934072, 6598.076269322299, 6602.438792702626, 6605.405513503808, 6616.172978377703, 6205.8138255851945, 6235.064740288993, 6237.220347456568, 6249.9062514062325, 6253.562250642457, 6508.446782023581, 6584.9012264816065, 6612.702428390734, 6766.8646627068165, 6781.6609169541325, 6287.717052732638, 6298.338674439118, 6340.492760579143, 6341.841453963595, 6352.174217351715, 6541.967290163614, 6576.210854697467, 6578.671066446658, 6582.24304205013, 6582.670866456658, 6093.055576385667, 6386.07401926718, 6457.935420645827, 6466.547341686037, 6475.0, 5708.31500219968, 6287.339829317947, 6287.49700023997, 6291.339409362043, 6316.684165791692, 4534.727916325031, 5206.01085793698, 5262.210668399694, 5299.152135658276, 5304.389995150607, 4599.816007359668, 4630.027694184192, 4660.487346391894, 4670.1126785910565, 4677.181493238738, 6205.22434695663, 6220.34686357935, 6220.657863817443, 6221.906671399933, 6229.56393052482, 6279.340669229665, 6363.7772677956045, 6374.394432528902, 6380.202474690664, 6386.680665966683, 6145.494353883238, 6169.722362493699, 6185.288691800411, 6208.72060757258, 6213.813585592439, 5751.1085781703905, 5767.740451679684, 5786.623869448473, 5790.565707571865, 5814.738336774855, 6703.759804436195, 6734.494912881553, 6746.089277947414, 6751.088603038527, 6759.155105611799, 6273.372662733873, 6355.3326900674765, 6361.2048493938255, 6362.840928976628, 6372.9362706374195, 6555.573887697285, 6696.497762667722, 6747.662616869039, 6748.257691654012, 6779.762708305383, 6411.935880641134, 6480.805575832733, 6498.025296205418, 6500.674966251763, 6506.902396463962, 6458.031295305742, 6570.310117437601, 6573.3426657333885, 6584.374484423972, 6620.3710647488415, 6016.42843929826, 6181.505479561714, 6244.906326405016, 6283.842903927439, 6365.236171659245, 5861.0, 6288.27684816252, 6324.430801227912, 6339.366063393623, 6351.396617321532, 6198.969005154945, 6262.966610509215, 6264.404881536247, 6272.749090036347, 6285.842853928689, 6205.441510264098, 6223.128761973237, 6242.687865606792, 6251.0, 6365.936340636535, 6166.599171053867, 6176.81469555914, 6183.196184495987, 6186.288576813724, 6198.380161983946], "value": 5952.626907908167, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.7595781371052, 790.1466416270426, 810.3193317613205, 1118.5749415222215, 1128.5090985421348, 27584.724152758467, 27928.0, 27953.860230698818, 28003.299917502074, 28005.299867503323, 27967.720322796766, 38311.042223944416, 38429.61570384295, 38515.0, 38526.0, 8520.190581894725, 8691.521966291852, 8701.956490217572, 8706.521141337224, 8711.215990560848, 8533.359998000144, 8654.307655387554, 8681.479111253346, 8688.43525170865, 8689.391742578022, 6131.080337949321, 6280.748770049193, 8573.52845593492, 8730.432521886058, 8762.430442021248, 8747.125287471266, 8799.824003519925, 8806.515641639708, 8816.823663526759, 8827.646894124227, 8414.158584141536, 8518.27594654455, 8537.445066070748, 8538.188872057144, 8557.657693692245, 25506.10728624508, 25938.22185334443, 25945.351366215808, 26025.73974260252, 36811.447828282595, 3187.792793468417, 3566.6789988901123, 3609.981950090259, 3611.9097022574383, 3621.583517895423, 30003.69996300031, 30118.698813011808, 30121.548176777367, 30161.396772064654, 30179.849100754574, 3147.35479226758, 3186.6654001329757, 3188.617365916082, 3213.453712868818, 3221.114193596756, 209745.9999999985, 257917.0, 258055.7097214502, 258264.0, 258270.0, 47597.76201118972, 47627.80838490974, 47771.52228477671, 47811.28283075757, 47851.76074119607, 47565.19478441717, 47590.76204618955, 47640.0, 47653.0, 47671.0, 14306.141631502143, 14413.567592972227, 14420.567382978528, 14428.206448645215, 14495.057821241586, 11759.235649682743, 11781.234219775688, 11796.351200684045, 11804.58683946075, 11805.586804461802, 12355.0, 12486.375681216085, 12533.623991280276, 12540.87459125397, 12682.302473363869, 4798.777076173015, 4886.95113048865, 4890.1931181355385, 4892.19278818998, 4908.460069392364, 854.2695994924375, 972.8617517504537, 980.9013904427087, 982.4400091947522, 1034.3380236648552, 22883.542329153657, 23721.16975905835, 23763.762362376154, 23816.761832381453, 23954.161604343764, 932.3566738950103, 1129.0121143999002, 1132.1961407400838, 1150.390293144618, 1150.5673350157906, 11376.0, 12147.149699520949, 12156.574519891761, 12174.424634039371, 12183.4332777625, 310934.0, 311114.0, 311286.0, 311462.0, 311729.0, 42814.57185428168, 51706.48293517092, 51843.740781295855, 52100.21849672258, 52140.47859521432, 1498.168516473346, 1528.8700460460764, 1541.52212814028, 1543.4443600303882, 1552.2394026926725, 19933.800661993195, 23449.882750586137, 23637.0, 23695.52608947846, 23716.169934052225, 37696.05759855916, 37713.0, 37756.43365349577, 37770.62229377781, 38019.04952376213, 281773.0, 283400.0, 283603.0, 283627.0, 283816.0, 34167.97496075122, 34224.486632700035, 34254.0, 34265.48601771025, 34275.485867711504, 42374.152516948874, 42792.0, 42958.0, 43007.13985720331, 43086.0, 28327.29181770472, 29184.0, 29323.560146597392, 30135.04122232048, 30271.545926810675, 29336.26659333534, 29507.85246073756, 29596.556051659674, 29882.70117298886, 30147.944821932004, 35357.469637954935, 36006.45990310095, 36041.459378109874, 36064.63935360613, 36089.45865811963, 29449.85275073611, 29788.702112978594, 30147.69852301449, 30282.0, 30297.697023029486, 19563.413097607096, 21854.235101771363, 23319.650205247275, 23796.0, 24862.12982545602], "value": 16780.450126355634, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.5240655984027, 437.1639115714001, 438.5986822057817, 444.24256642424666, 456.94288213973255, 18499.53751156222, 21067.47331316716, 21357.57284854302, 21943.122275108995, 22132.778672213273, 22616.321510354675, 23350.0, 23352.94911728972, 23589.882050589767, 23769.76230237697, 6056.242969628796, 6065.514758819284, 6285.308616052231, 6339.11252424661, 6411.487081033506, 3744.794036328001, 6375.585586936834, 6419.5506314558, 6429.967850160766, 6433.356664333576, 3820.388737801952, 3938.7833669148185, 4030.375291829771, 6402.583832050925, 6408.455281301095, 6164.9519581670775, 6392.904106438407, 6407.487401007931, 6408.327125651809, 6448.93551064488, 5588.524975377098, 5612.69130197839, 5615.438456154393, 5624.91562626561, 5631.408702086263, 28273.434531309464, 28326.716732832614, 28336.716632833613, 28450.288742781388, 28556.428871422457, 2241.3724157236, 2279.2364557873134, 2281.5208806150727, 2284.9657255141187, 2285.5086156476436, 16309.51071467858, 16986.895851769594, 17559.29762809486, 17689.646207075788, 17832.197551110232, 2092.5710229402935, 2146.5170336674278, 2180.13884515617, 2184.311941738363, 2197.9340619781433, 155807.88384232364, 163613.0, 165050.1747491255, 166179.0, 167937.1603142001, 10746.677599672023, 11316.71708207285, 11811.645650630322, 12338.753224935452, 12576.11967162308, 16357.427490037791, 16370.644017976287, 16479.505614831574, 16494.67010659804, 16508.42220522276, 7563.810904727426, 8938.955305223431, 8999.82000359989, 9109.27125829932, 9193.402428842104, 8641.913580864237, 8678.609462574199, 8686.0, 8842.734717958472, 8880.467171969573, 6448.806535803933, 7718.488087919983, 7853.646585903648, 7901.0, 8075.757727268191, 1976.7430234069766, 1992.2728204205362, 2135.7116789233255, 2159.438545978057, 2323.2101085630966, 961.1829944547219, 961.697065424389, 968.8110818390487, 1006.9798604027878, 1009.2228983682523, 18128.637427251382, 21313.360599182048, 21385.572288554144, 21391.03740331689, 21644.24245151412, 951.9714408567615, 975.7853272280087, 981.8527220916919, 1018.2464975917916, 1019.261035749076, 10971.0, 11113.888861111447, 11208.943955280172, 11220.831687524693, 11478.311301321948, 654729.0, 661972.0, 737932.0, 741820.0, 751854.0, 147390.0, 156970.3029697021, 160431.19784401002, 162689.0, 163690.0, 1154.2151337090859, 1231.6428235811513, 1254.2599866078874, 1257.9999999999816, 1259.9433025513874, 22190.67281880018, 22390.313162420614, 22681.092756289563, 22778.0, 22884.0, 58048.034235891966, 62484.75030499455, 62824.68587657032, 63717.681411592646, 64825.0, 88944.6658300113, 90644.0, 92190.0, 93234.53382733042, 93302.0, 8672.132786721277, 8736.606852691517, 8916.375853690179, 9014.864777028219, 9289.86065209036, 14020.929895350459, 14214.786778198128, 14615.050021748551, 14674.972751907264, 14708.55874323772, 11680.240784348991, 11860.0, 12155.453004614637, 12212.206206596542, 12219.633410997685, 11317.886821131684, 11330.490127944428, 11527.250728702607, 11626.651200463999, 11654.766904662029, 12124.818127727915, 12133.0, 12235.204711693712, 12432.316222607844, 12539.24764514132, 7745.302922736981, 8360.749177524684, 8578.356623253156, 9054.773630659287, 9065.68270110543, 11803.350815705218, 11914.821277680669, 12275.508979641072, 12294.446749896455, 12466.252024878537], "value": 10711.48859409477, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.1924704800642, 1426.329625076214, 1439.5465428390053, 1446.3636000159922, 1451.3251338127768, 9660.227181825454, 11566.942165289172, 11569.479373428196, 11581.826272605897, 11589.65231043069, 11591.536338546448, 11659.00898423635, 11988.040956723464, 12064.638060858188, 12069.818952715716, 2163.2320526213243, 2558.0663057983793, 2559.9488010239784, 2562.1801023672433, 2568.4092658688514, 2436.4517983453757, 2475.900963961439, 2478.9008439662393, 2480.2063339731294, 2480.5659009673327, 2458.2870967419426, 2558.155808583163, 2560.4879024195143, 2561.6541766861424, 2562.654041704374, 2476.7770900618852, 2513.5098655762135, 2539.377852426149, 2542.1229675761833, 2565.9992602884795, 2487.7014758228947, 2497.7002759668776, 2512.522620702061, 2516.471540976397, 2519.433127546306, 11166.888331116666, 11240.437978101145, 11989.340586267752, 12091.637250882399, 12117.636470905887, 6557.245916719543, 6830.146231721035, 6831.521793474459, 6832.795016149524, 6837.521373503857, 4065.7967101645095, 4315.676324275661, 4320.65434765218, 4408.823647054114, 4422.7346359218545, 1232.5624403336776, 1263.6019653809021, 1309.332240557313, 1310.1745900082983, 1314.5464814638933, 15033.624159396102, 15520.0, 15558.222088895624, 16567.92308499956, 16710.58223544409, 4591.632669386441, 5510.0632892408385, 5755.884882302415, 5759.510441612426, 5772.0, 12434.937825310815, 12467.376631168405, 12469.376531173404, 12477.376131193403, 12479.31363775001, 6566.737330506726, 6602.372774586406, 6613.801585952429, 6622.9006564901565, 6653.201615806134, 6095.878082438415, 6105.145279660851, 6162.198914141133, 6219.533534984895, 6252.999520076766, 3953.469779341224, 4053.054533823781, 4087.46862907826, 4092.058826469869, 4124.8556300529335, 1110.3781882145863, 1277.9808302875465, 1284.344984058137, 1285.5243559882904, 1300.668329575971, 785.0, 792.3061590592033, 810.2707563193173, 816.8039670479161, 833.3916241143999, 6198.101275315054, 6209.379062093754, 6432.195975503062, 6468.5472016958365, 6590.242122155918, 577.6418620455345, 593.6942474625571, 599.6282304970946, 812.622130709223, 815.1603848036532, 4323.83808095952, 4399.978000109979, 4524.8416305429155, 4545.977270113628, 4568.0, 14851.554453366416, 14972.850271497146, 15536.300866461037, 15539.84460155384, 15580.220988950507, 15144.621384465476, 15282.770758438632, 15418.922905385625, 15444.227788610524, 15449.150296733562, 8597.785055373666, 11122.777544449227, 11188.720281992852, 11193.49629266685, 11215.271007384494, 5772.7402266898935, 7040.331168538981, 7218.205997340393, 7219.241979592067, 7247.8550428990075, 12463.314517701614, 12557.560485383334, 12694.428750706425, 12754.936225318814, 12795.42420591057, 13831.585052448443, 13908.51320203788, 13953.953453490825, 14156.787648185491, 14201.644958875697, 8718.0, 8747.868781968404, 8774.605142768718, 8915.73252802417, 8918.241949434112, 10735.677929662123, 10845.891541084804, 10846.728831778953, 10867.782644347228, 10872.945635271773, 9013.278937684838, 9268.814623707352, 9282.396644218104, 9372.531373431437, 9500.85748713756, 9088.409253398508, 9175.816483670424, 9226.0, 9255.722328329892, 9338.066193380608, 7156.248593897566, 8206.179382061984, 8402.327813775006, 8431.747047588582, 8436.0, 5469.097598896296, 6038.607490513103, 6053.697315134314, 6056.182415373868, 6182.907256391248, 5044.319016932667, 5496.945030549803, 6281.214848143982, 6352.936470635234, 6437.871242575216], "value": 5383.854513950571, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.33352299384103, 396.1996766531606, 396.8095314249162, 397.87466947911406, 411.7118017387829, 5014.047331007111, 5645.74594143263, 5697.704037039064, 5705.343885453174, 5724.2558467399285, 4520.005598768265, 5210.9739451302785, 5596.944030559694, 5626.887462250763, 5657.23627310313, 3740.3828368319196, 4440.689151759379, 4460.30865215892, 4488.416505854234, 4497.70764900282, 4437.778111094449, 4446.799894004761, 4448.755318457484, 4470.418845550074, 4539.455265368144, 3545.592256890452, 4349.41282926804, 4424.955750442503, 4481.7983190756495, 4487.483939346984, 4394.60448559628, 4423.60187583119, 4431.202383570956, 4435.733855968652, 4439.733615983019, 3905.882823515299, 3912.902177445558, 3916.746641074857, 3950.7036972227197, 3985.461962635065, 4711.24620060792, 5407.648502847342, 5570.693611851347, 5601.495865372136, 5686.289213848269, 4476.485204201494, 4511.548845115495, 5083.669561478492, 5362.731863406814, 5368.194770784375, 5383.892322153574, 6196.8760624787255, 6196.907046394308, 6216.2851272103835, 6232.345603711636, 3983.322835118008, 4116.91766164675, 4193.685473589493, 4471.642268618502, 4496.685232033759, 5284.81503147388, 6004.778232054168, 6117.021276595768, 6313.715882785285, 6322.241331040213, 4180.6446452051305, 4267.615914567704, 4280.850170244026, 4295.140971805651, 4318.330658747836, 3972.066564357374, 4134.524529679125, 4324.589164029412, 4334.761588112684, 4342.58986262621, 4580.312953057001, 4689.5848637951485, 4773.0, 4782.282657601388, 4877.609791216694, 6043.7884674036195, 6044.788432404845, 6067.757289708362, 6074.969625151934, 6091.725872335755, 1396.9161850289015, 1444.443889102682, 1458.6863824277832, 1475.5425817996456, 1481.3111902965172, 963.3689933093834, 991.2417000994245, 996.4270544436832, 998.2912132385942, 1000.1248907206194, 4852.611791056707, 5772.018756811352, 5790.073588225863, 5794.420557944172, 5828.5120457247685, 4959.776810043557, 6147.415995480422, 6252.249730032425, 6269.937300626935, 6310.873782524323, 5711.514521265656, 5736.196932429463, 5738.282714660668, 5743.4543718346695, 5751.252337196138, 2750.5049091163382, 3040.619922509686, 3270.721988630993, 3284.6350627548127, 3296.901092967215, 6419.903701444482, 6426.839329016719, 6441.935580644227, 6447.2263328400895, 6455.903161452582, 6094.257048438488, 6226.688665566703, 6446.580972236789, 6458.38645328693, 6537.215534135934, 5460.334597947664, 6395.744170233232, 6455.483561315177, 6471.2759685428955, 6511.609303441809, 6084.452399284086, 6158.69049106585, 6203.852287326859, 6305.4009869062365, 6319.58922670025, 5067.645264831426, 5411.810586629449, 5854.736536855767, 6008.339082700987, 6039.516838652809, 5774.624649397776, 5797.76808927655, 6334.809955701337, 6355.5551111421755, 6374.1394911688185, 3313.3042061167425, 4097.930545074718, 4156.667466602604, 4202.2435961526, 4228.492580890313, 5761.683107429131, 5832.883342333214, 5884.617114978062, 6045.0, 6332.810015699536, 4868.95131048685, 6017.458428741435, 6122.4795892347865, 6148.846278843064, 6156.938430615815, 4855.927161092657, 5160.845174644766, 6089.5737298388685, 6097.237845269341, 6109.389061093855, 4866.90266194667, 5396.227734193562, 5564.85920386328, 5717.342505611741, 5760.913586296293, 4851.587615052619, 6046.213992181164, 6050.30421501533, 6059.454649081604, 6113.57204995646, 4774.16194765011, 4914.262860570943, 5636.267285252891, 5930.229070220844, 5995.910061348996], "value": 4459.474494936754, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.3023222126208, 849.2738708404314, 860.0281681699679, 863.145485968891, 876.7413612984169, 13247.403866825993, 17945.01302428366, 18689.34587289445, 18709.34517291895, 18736.531586710338, 16797.42546748354, 17099.31602735892, 17182.484525464257, 17220.0, 17238.310467581312, 954.1984732824409, 962.3552220012573, 986.4919566423262, 987.4568987057125, 987.7876256604828, 676.0974099577071, 695.6417445015821, 949.8195342884829, 984.07988530724, 996.9102780749731, 1035.5236591168073, 1036.4040676610941, 1039.0648416425202, 1039.0907955538903, 1052.1372474570856, 1030.7526193713454, 1032.3496197395593, 1033.8707661542308, 1035.0012238190106, 1041.7760181560964, 762.0436352377731, 764.6024067484876, 768.4352001279055, 769.2115581528922, 772.3628006894335, 16239.51281461558, 16504.66990660192, 16571.42000030005, 16737.497875063767, 16765.66468670632, 16782.160891955355, 16829.83170168295, 17063.061531615756, 17222.827771722248, 17243.568910777205, 13836.377363018688, 13943.023988320821, 13963.720725585432, 13965.231912244823, 14189.935754818327, 3403.7277017838514, 3426.126337783849, 3426.400379933502, 3430.9485357719655, 3432.4508078707536, 107704.4614776929, 108289.0, 108302.91697083008, 108339.0, 108397.37403938947, 11282.605108821152, 11653.30080195174, 12300.81548776769, 13198.538051168354, 13569.728605427836, 18799.718004229948, 19808.108635111454, 20550.69173962392, 25230.0, 25328.0, 7968.203179682101, 8761.737147885573, 8798.0, 9040.502772347452, 9046.773830654154, 4779.091972525209, 4874.171390863562, 4874.4150701916, 4876.317315575822, 4876.780544875489, 4278.272693642026, 4309.633681137138, 4382.912341753211, 4405.7797110144365, 4414.470263568328, 885.5527958381106, 899.7480705402497, 959.6161535385762, 967.0184762466102, 969.2778879734643, 642.5277421095491, 668.7893313606198, 672.028918213187, 678.0778141727247, 702.3187508117118, 11469.770604587862, 11668.289759532516, 11900.166988310735, 12070.396480175956, 12311.938440307742, 639.0350570638277, 657.3722095398882, 659.5679829711546, 690.3441730356082, 699.2448155991517, 4904.2643603459055, 4926.507349265116, 5594.356648985337, 5659.094544872801, 5688.431156884279, 84362.0, 103933.48033259786, 105206.47396762967, 105628.0, 105793.47103264435, 91478.54260728654, 92854.07145928455, 93209.40743555408, 93506.38961662322, 97245.0, 81688.0, 81979.36041279142, 84344.15655843363, 84435.0, 84920.72618910721, 10424.791504170025, 10492.842607361048, 10807.35155890649, 10908.290961087503, 11075.169362297698, 36691.44962825506, 38491.8452446427, 38768.80615596904, 39078.413823793235, 39782.0, 50090.74954625204, 52988.4701152999, 64690.67654661697, 67680.0, 69526.65236673785, 16494.83505164933, 16684.749728753835, 16733.665326693153, 16758.82688211862, 16978.49064528066, 18282.268709251483, 18410.90794546019, 18528.0, 18603.81396186075, 18669.626607468046, 16713.5821604456, 16749.74875376895, 17189.742153867952, 17232.0, 17349.132543373034, 16367.263473143976, 16767.413140540022, 16868.57828554296, 17156.656866862842, 17226.0, 16169.59576010609, 16908.0, 16934.40729574459, 16958.236879340213, 17194.570135746206, 9826.705198844045, 10654.414007229676, 11469.598564050219, 11720.296782193096, 12153.392330383622, 10628.309159904582, 11986.381838451698, 13916.930415347859, 13937.445951282358, 14030.719385612027], "value": 8343.300608759313, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1639.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 102.0, 169.0, 102.0, 182.0, 178.0, 176.0, 122.0, 121.0, 123.0], "value": 142.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 121.0, 117.0, 155.0, 111.0, 146.0, 148.0, 149.0, 143.0, 118.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [214.0, 214.0, 208.0, 207.0, 206.0, 217.0, 209.0, 208.0, 219.0, 219.0], "value": 212.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 64.0, 66.0, 99.0, 69.0, 64.0, 61.0, 64.0, 80.0, 66.0], "value": 71.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 77.0, 94.0, 76.0, 74.0, 73.0, 94.0, 74.0, 74.0, 92.0], "value": 82.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 92.0, 92.0, 91.0, 91.0, 92.0, 97.0, 138.0, 90.0, 91.0], "value": 96.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 99.0, 102.0, 101.0, 99.0, 100.0, 103.0, 156.0, 156.0, 100.0], "value": 111.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 132.0, 164.0, 102.0, 101.0, 101.0, 101.0, 99.0, 100.0, 102.0], "value": 110.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 51.0, 53.0, 52.0, 54.0, 53.0, 53.0, 53.0, 52.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 71.0, 68.0, 70.0, 66.0, 63.0, 64.0, 64.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 91.0, 95.0, 111.0, 116.0, 117.0, 92.0, 90.0, 91.0], "value": 98.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 163.0, 162.0, 168.0, 139.0, 170.0, 148.0, 201.0, 154.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 255.0, 212.0, 199.0, 203.0, 204.0, 200.0, 203.0, 234.0, 185.0], "value": 209.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 65.0, 91.0, 108.0, 99.0, 102.0, 95.0, 73.0, 75.0, 75.0], "value": 86.0, "unit": "score"}]}]} 13:18:51 INFO - Return code: 0 13:18:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:18:51 ERROR - # TBPL SUCCESS # 13:18:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:18:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:18:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:18:51 INFO - 2017-04-09 13:18:51.397 screenresolution[1653:10173] starting screenresolution argv=screenresolution get 13:18:51 INFO - 2017-04-09 13:18:51.399 screenresolution[1653:10173] Display 0: 1600x1200x32@60 13:18:51 INFO - 2017-04-09 13:18:51.406 screenresolution[1654:10176] starting screenresolution argv=screenresolution list 13:18:51 INFO - Available Modes on Display 0 13:18:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:18:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:18:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:18:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:18:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:18:51 INFO - Intel Iris: 13:18:51 INFO - Chipset Model: Intel Iris 13:18:51 INFO - Type: GPU 13:18:51 INFO - Bus: Built-In 13:18:51 INFO - VRAM (Dynamic, Max): 1536 MB 13:18:51 INFO - Vendor: Intel (0x8086) 13:18:51 INFO - Device ID: 0x0a2e 13:18:51 INFO - Revision ID: 0x0009 13:18:51 INFO - Displays: 13:18:51 INFO - Display: 13:18:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:18:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:18:51 INFO - Display Serial Number: 1600x1200 60 13:18:51 INFO - Main Display: Yes 13:18:51 INFO - Mirror: Off 13:18:51 INFO - Online: Yes 13:18:51 INFO - Rotation: Supported 13:18:51 INFO - Return code: 0 13:18:51 INFO - Running post-action listener: _resource_record_post_action 13:18:51 INFO - [mozharness: 2017-04-09 20:18:51.656650Z] Finished run-tests step (success) 13:18:51 INFO - Running post-run listener: _resource_record_post_run 13:18:51 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 32783360; Write bytes: 515401728; Read time: 195; Write time: 1577 13:18:51 INFO - TinderboxPrint: CPU usage
53.6% 13:18:51 INFO - TinderboxPrint: I/O read bytes / time
32,783,360 / 195 13:18:51 INFO - TinderboxPrint: I/O write bytes / time
515,401,728 / 1,577 13:18:51 INFO - TinderboxPrint: CPU idle
2,234.2 (46.4%) 13:18:51 INFO - TinderboxPrint: CPU system
964.7 (20.0%) 13:18:51 INFO - TinderboxPrint: CPU user
1,618.8 (33.6%) 13:18:51 INFO - TinderboxPrint: Swap in / out
235,991,040 / 0 13:18:51 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 192178688; Write bytes: 194889728; Read time: 14903; Write time: 419 13:18:51 INFO - run-tests - Wall time: 1185s; CPU: 54.0%; Read bytes: 31853568; Write bytes: 303665152; Read time: 183; Write time: 1106 13:18:52 INFO - Running post-run listener: _upload_blobber_files 13:18:52 INFO - Blob upload gear active. 13:18:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:18:52 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 13:18:52 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'] 13:18:52 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 13:18:52 INFO - (blobuploader) - INFO - Open directory for files ... 13:18:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:18:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:18:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:18:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:18:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:18:53 INFO - (blobuploader) - INFO - Done attempting. 13:18:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:18:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:18:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:18:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:18:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:18:54 INFO - (blobuploader) - INFO - Done attempting. 13:18:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:18:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:18:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:18:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:18:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:18:55 INFO - (blobuploader) - INFO - Done attempting. 13:18:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:18:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:18:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:18:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:18:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:18:57 INFO - (blobuploader) - INFO - Done attempting. 13:18:57 INFO - (blobuploader) - INFO - Iteration through files over. 13:18:57 INFO - Return code: 0 13:18:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:18:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:18:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b97dd4167cc973228587cbe812f8c5f26d76c8d2ec2b01a666bc09d61212affc260bf569d662d5de367c6619d4c59f96e872b2c35be29f2cf3c92e40cab60d35", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa95658726d80d3de7e05bd282cce03e969df985435f630993fcb8082ad13e294c7c56742de5691faeb0edeaeda9989aaa6010b03ce5c2cebfa4ebf0cbb67fdf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e195b3c04a5d6d578d00f4bb8c8ee321bbc4cdacf0ecdfe7fb00286306153a58fef0579ef0d02f8e7aeec3fc3b30178765b042df78647bd5d3a931d122910fad", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e03f9a0f3b7022265fea56b2f2c1309ca306310c1f10739f294af4759d3e2f4cf5d9d6e4685f478c353b86cc63cff664479f575e018b305769cc0c982ad6364"} 13:18:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:18:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:18:57 INFO - Contents: 13:18:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b97dd4167cc973228587cbe812f8c5f26d76c8d2ec2b01a666bc09d61212affc260bf569d662d5de367c6619d4c59f96e872b2c35be29f2cf3c92e40cab60d35", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa95658726d80d3de7e05bd282cce03e969df985435f630993fcb8082ad13e294c7c56742de5691faeb0edeaeda9989aaa6010b03ce5c2cebfa4ebf0cbb67fdf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e195b3c04a5d6d578d00f4bb8c8ee321bbc4cdacf0ecdfe7fb00286306153a58fef0579ef0d02f8e7aeec3fc3b30178765b042df78647bd5d3a931d122910fad", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e03f9a0f3b7022265fea56b2f2c1309ca306310c1f10739f294af4759d3e2f4cf5d9d6e4685f478c353b86cc63cff664479f575e018b305769cc0c982ad6364"} 13:18:57 INFO - Running post-run listener: copy_logs_to_upload_dir 13:18:57 INFO - Copying logs to upload dir... 13:18:57 INFO - mkdir: /builds/slave/test/build/upload/logs 13:18:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1289.556278 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-04-09 13:18:57.798818) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-09 13:18:57.801897) ========= 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.yXBjBQTVwL/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.k0qadRKOjp/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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/b97dd4167cc973228587cbe812f8c5f26d76c8d2ec2b01a666bc09d61212affc260bf569d662d5de367c6619d4c59f96e872b2c35be29f2cf3c92e40cab60d35", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa95658726d80d3de7e05bd282cce03e969df985435f630993fcb8082ad13e294c7c56742de5691faeb0edeaeda9989aaa6010b03ce5c2cebfa4ebf0cbb67fdf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e195b3c04a5d6d578d00f4bb8c8ee321bbc4cdacf0ecdfe7fb00286306153a58fef0579ef0d02f8e7aeec3fc3b30178765b042df78647bd5d3a931d122910fad", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e03f9a0f3b7022265fea56b2f2c1309ca306310c1f10739f294af4759d3e2f4cf5d9d6e4685f478c353b86cc63cff664479f575e018b305769cc0c982ad6364"} build_url:https://queue.taskcluster.net/v1/task/TCEdOkYOTe6xZGXsEyMtvA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011199 build_url: 'https://queue.taskcluster.net/v1/task/TCEdOkYOTe6xZGXsEyMtvA/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/b97dd4167cc973228587cbe812f8c5f26d76c8d2ec2b01a666bc09d61212affc260bf569d662d5de367c6619d4c59f96e872b2c35be29f2cf3c92e40cab60d35", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa95658726d80d3de7e05bd282cce03e969df985435f630993fcb8082ad13e294c7c56742de5691faeb0edeaeda9989aaa6010b03ce5c2cebfa4ebf0cbb67fdf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e195b3c04a5d6d578d00f4bb8c8ee321bbc4cdacf0ecdfe7fb00286306153a58fef0579ef0d02f8e7aeec3fc3b30178765b042df78647bd5d3a931d122910fad", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e03f9a0f3b7022265fea56b2f2c1309ca306310c1f10739f294af4759d3e2f4cf5d9d6e4685f478c353b86cc63cff664479f575e018b305769cc0c982ad6364"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-09 13:18:57.839842) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 13:18:57.840174) ========= 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.yXBjBQTVwL/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.k0qadRKOjp/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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.005236 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 13:18:57.889451) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-09 13:18:57.889766) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-09 13:18:57.890104) ========= ========= Total master_lag: 0.18 =========