builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0338 starttime: 1492685008.39 results: success (0) buildid: 20170420021428 builduid: 87fb75dabc6245bd97edcff5f648503f revision: 27311156637f9b5d4504373967e01c4241902ae7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-20 03:43:28.391833) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-20 03:43:28.392425) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-20 03:43:28.392724) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-20 03:43:28.419112) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 03:43:28.419510) ========= 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.XDMkKt3QQc/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.TN9sPn0bEf/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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-20 03:43:28-- 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% 18.6M=0.001s 2017-04-20 03:43:28 (18.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.143744 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 03:43:28.587394) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 03:43:28.587722) ========= 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.XDMkKt3QQc/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.TN9sPn0bEf/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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.026732 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 03:43:28.636594) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-20 03:43:28.636952) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 27311156637f9b5d4504373967e01c4241902ae7 --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 27311156637f9b5d4504373967e01c4241902ae7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XDMkKt3QQc/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.TN9sPn0bEf/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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-20 03:43:28,746 truncating revision to first 12 chars 2017-04-20 03:43:28,746 Setting DEBUG logging. 2017-04-20 03:43:28,746 attempt 1/10 2017-04-20 03:43:28,746 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/27311156637f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-20 03:43:30,286 unpacking tar archive at: mozilla-central-27311156637f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.821869 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-20 03:43:30.482284) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-20 03:43:30.482652) ========= script_repo_revision: 27311156637f9b5d4504373967e01c4241902ae7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-20 03:43:30.483046) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-20 03:43:30.483352) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-20 03:43:30.503706) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-20 03:43:30.504106) ========= /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.XDMkKt3QQc/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.TN9sPn0bEf/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 03:43:30 INFO - MultiFileLogger online at 20170420 03:43:30 in /builds/slave/test 03:43:30 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 03:43:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:43:30 INFO - {'append_to_log': False, 03:43:30 INFO - 'base_work_dir': '/builds/slave/test', 03:43:30 INFO - 'blob_upload_branch': 'Firefox', 03:43:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:43:30 INFO - 'branch': 'Firefox', 03:43:30 INFO - 'buildbot_json_path': 'buildprops.json', 03:43:30 INFO - 'config_files': ('talos/mac_config.py',), 03:43:30 INFO - 'default_actions': ('clobber', 03:43:30 INFO - 'read-buildbot-config', 03:43:30 INFO - 'download-and-extract', 03:43:30 INFO - 'populate-webroot', 03:43:30 INFO - 'create-virtualenv', 03:43:30 INFO - 'install', 03:43:30 INFO - 'run-tests'), 03:43:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:43:30 INFO - 'download_minidump_stackwalk': True, 03:43:30 INFO - 'download_symbols': 'ondemand', 03:43:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:43:30 INFO - 'tooltool.py': '/tools/tooltool.py', 03:43:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:43:30 INFO - '/tools/misc-python/virtualenv.py')}, 03:43:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:43:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:43:30 INFO - 'gecko_profile': False, 03:43:30 INFO - 'gecko_profile_interval': 0, 03:43:30 INFO - 'installer_path': 'installer.exe', 03:43:30 INFO - 'log_level': 'info', 03:43:30 INFO - 'log_name': 'talos', 03:43:30 INFO - 'log_to_console': True, 03:43:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:43:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:43:30 INFO - 'opt_config_files': (), 03:43:30 INFO - 'pip_index': False, 03:43:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:43:30 INFO - 'cmd': ('bash', 03:43:30 INFO - '-c', 03:43:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:43:30 INFO - 'enabled': True, 03:43:30 INFO - 'halt_on_failure': False, 03:43:30 INFO - 'name': 'check_screen_resolution'},), 03:43:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:43:30 INFO - 'cmd': ('bash', 03:43:30 INFO - '-c', 03:43:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:43:30 INFO - 'enabled': True, 03:43:30 INFO - 'halt_on_failure': False, 03:43:30 INFO - 'name': 'check_screen_resolution'},), 03:43:30 INFO - 'run_cmd_checks_enabled': True, 03:43:30 INFO - 'suite': 'dromaeojs', 03:43:30 INFO - 'system_bits': '32', 03:43:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:43:30 INFO - 'title': 't-yosemite-r7-0338', 03:43:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:43:30 INFO - 'use_talos_json': True, 03:43:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:43:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:43:30 INFO - 'work_dir': 'build'} 03:43:30 INFO - [mozharness: 2017-04-20 10:43:30.715448Z] Running clobber step. 03:43:30 INFO - Running pre-action listener: _resource_record_pre_action 03:43:30 INFO - Running main action method: clobber 03:43:30 INFO - rmtree: /builds/slave/test/build 03:43:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:43:33 INFO - Running post-action listener: _resource_record_post_action 03:43:33 INFO - [mozharness: 2017-04-20 10:43:33.174330Z] Finished clobber step (success) 03:43:33 INFO - [mozharness: 2017-04-20 10:43:33.174553Z] Running read-buildbot-config step. 03:43:33 INFO - Running pre-action listener: _resource_record_pre_action 03:43:33 INFO - Running main action method: read_buildbot_config 03:43:33 INFO - Using buildbot properties: 03:43:33 INFO - { 03:43:33 INFO - "project": "", 03:43:33 INFO - "product": "firefox", 03:43:33 INFO - "script_repo_revision": "production", 03:43:33 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 03:43:33 INFO - "repository": "", 03:43:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 03:43:33 INFO - "buildid": "20170420021428", 03:43:33 INFO - "pgo_build": "False", 03:43:33 INFO - "basedir": "/builds/slave/test", 03:43:33 INFO - "buildnumber": 102, 03:43:33 INFO - "slavename": "t-yosemite-r7-0338", 03:43:33 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 03:43:33 INFO - "platform": "yosemite_r7", 03:43:33 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:43:33 INFO - "branch": "mozilla-central", 03:43:33 INFO - "repo_path": "mozilla-central", 03:43:33 INFO - "revision": "27311156637f9b5d4504373967e01c4241902ae7", 03:43:33 INFO - "stage_platform": "macosx64", 03:43:33 INFO - "builduid": "87fb75dabc6245bd97edcff5f648503f", 03:43:33 INFO - "slavebuilddir": "test" 03:43:33 INFO - } 03:43:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/TYjExR9nTrahq3TTfwGFEA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 03:43:33 INFO - Running post-action listener: _resource_record_post_action 03:43:33 INFO - [mozharness: 2017-04-20 10:43:33.180103Z] Finished read-buildbot-config step (success) 03:43:33 INFO - [mozharness: 2017-04-20 10:43:33.180330Z] Running download-and-extract step. 03:43:33 INFO - Running pre-action listener: _resource_record_pre_action 03:43:33 INFO - Running main action method: download_and_extract 03:43:33 INFO - mkdir: /builds/slave/test/build/tests 03:43:33 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')]} 03:43:33 INFO - trying https://queue.taskcluster.net/v1/task/TYjExR9nTrahq3TTfwGFEA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 03:43:33 INFO - Downloading https://queue.taskcluster.net/v1/task/TYjExR9nTrahq3TTfwGFEA/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 03:43:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TYjExR9nTrahq3TTfwGFEA/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 03:43:34 INFO - Downloaded 1325 bytes. 03:43:34 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 03:43:34 INFO - Using the following test package requirements: 03:43:34 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:43:34 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 03:43:34 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:43:34 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:43:34 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 03:43:34 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:43:34 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 03:43:34 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:43:34 INFO - u'jsshell-mac.zip'], 03:43:34 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:43:34 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 03:43:34 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:43:34 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:43:34 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 03:43:34 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:43:34 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 03:43:34 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:43:34 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 03:43:34 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:43:34 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 03:43:34 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:43:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TYjExR9nTrahq3TTfwGFEA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:43:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TYjExR9nTrahq3TTfwGFEA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:43:34 INFO - Fetch https://queue.taskcluster.net/v1/task/TYjExR9nTrahq3TTfwGFEA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:43:36 INFO - Expected file size: 52521305 03:43:36 INFO - Obtained file size: 52521305 03:43:52 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 03:43:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TYjExR9nTrahq3TTfwGFEA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:43:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TYjExR9nTrahq3TTfwGFEA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:43:52 INFO - Fetch https://queue.taskcluster.net/v1/task/TYjExR9nTrahq3TTfwGFEA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:43:53 INFO - Expected file size: 52521305 03:43:53 INFO - Obtained file size: 52521305 03:44:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TYjExR9nTrahq3TTfwGFEA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 03:44:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TYjExR9nTrahq3TTfwGFEA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:44:09 INFO - Fetch https://queue.taskcluster.net/v1/task/TYjExR9nTrahq3TTfwGFEA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 03:44:10 INFO - Expected file size: 14408811 03:44:10 INFO - Obtained file size: 14408811 03:44: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')]} 03:44:10 INFO - trying https://queue.taskcluster.net/v1/task/TYjExR9nTrahq3TTfwGFEA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:44:10 INFO - Downloading https://queue.taskcluster.net/v1/task/TYjExR9nTrahq3TTfwGFEA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 03:44:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TYjExR9nTrahq3TTfwGFEA/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 03:44:12 INFO - Downloaded 70990879 bytes. 03:44:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TYjExR9nTrahq3TTfwGFEA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:44:12 INFO - mkdir: /builds/slave/test/properties 03:44:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:44:12 INFO - Writing to file /builds/slave/test/properties/build_url 03:44:12 INFO - Contents: 03:44:12 INFO - build_url:https://queue.taskcluster.net/v1/task/TYjExR9nTrahq3TTfwGFEA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:44:13 INFO - Running post-action listener: _resource_record_post_action 03:44:13 INFO - Running post-action listener: set_extra_try_arguments 03:44:13 INFO - [mozharness: 2017-04-20 10:44:13.696879Z] Finished download-and-extract step (success) 03:44:13 INFO - [mozharness: 2017-04-20 10:44:13.697004Z] Running populate-webroot step. 03:44:13 INFO - Running pre-action listener: _resource_record_pre_action 03:44:13 INFO - Running main action method: populate_webroot 03:44:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:44:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:44:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:44:13 INFO - '--tppagecycles', 03:44:13 INFO - '7'], 03:44:13 INFO - 'tests': ['tsvgm']}}, 03:44:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:44:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:44:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:44:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:44:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:44:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:44:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:44:13 INFO - 'talos_options': ['--disable-e10s'], 03:44:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:44:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:44:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:44:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:44:13 INFO - 'talos_options': ['--disable-e10s'], 03:44:13 INFO - 'tests': ['damp', 'tps']}, 03:44:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:44:13 INFO - 'tests': ['damp', 'tps']}, 03:44:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:44:13 INFO - 'tests': ['dromaeo_dom']}, 03:44:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:44:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:44:13 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:44:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:44:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:44:13 INFO - 'tests': ['a11yr', 03:44:13 INFO - 'ts_paint', 03:44:13 INFO - 'tpaint', 03:44:13 INFO - 'sessionrestore', 03:44:13 INFO - 'sessionrestore_no_auto_restore', 03:44:13 INFO - 'tabpaint']}, 03:44:13 INFO - 'other-e10s': {'tests': ['a11yr', 03:44:13 INFO - 'ts_paint', 03:44:13 INFO - 'tpaint', 03:44:13 INFO - 'sessionrestore', 03:44:13 INFO - 'sessionrestore_no_auto_restore', 03:44:13 INFO - 'tabpaint']}, 03:44:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:44:13 INFO - 'ts_paint', 03:44:13 INFO - 'tpaint', 03:44:13 INFO - 'sessionrestore', 03:44:13 INFO - 'sessionrestore_no_auto_restore', 03:44:13 INFO - 'tabpaint']}, 03:44:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:44:13 INFO - 'ts_paint', 03:44:13 INFO - 'tpaint', 03:44:13 INFO - 'sessionrestore', 03:44:13 INFO - 'sessionrestore_no_auto_restore', 03:44:13 INFO - 'tabpaint']}, 03:44:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:44:13 INFO - 'tests': ['a11yr', 03:44:13 INFO - 'ts_paint', 03:44:13 INFO - 'tpaint', 03:44:13 INFO - 'sessionrestore', 03:44:13 INFO - 'sessionrestore_no_auto_restore', 03:44:13 INFO - 'tabpaint']}, 03:44:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:44:13 INFO - 'tests': ['a11yr', 03:44:13 INFO - 'ts_paint', 03:44:13 INFO - 'tpaint', 03:44:13 INFO - 'sessionrestore', 03:44:13 INFO - 'sessionrestore_no_auto_restore', 03:44:13 INFO - 'tabpaint']}, 03:44:13 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:44:13 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:44:13 INFO - 'bloom_basic_ref']}, 03:44:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:44:13 INFO - 'tests': ['tsvgx', 03:44:13 INFO - 'tsvgr_opacity', 03:44:13 INFO - 'tart', 03:44:13 INFO - 'tscrollx', 03:44:13 INFO - 'cart', 03:44:13 INFO - 'tsvg_static']}, 03:44:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:44:13 INFO - 'tsvgr_opacity', 03:44:13 INFO - 'tart', 03:44:13 INFO - 'tscrollx', 03:44:13 INFO - 'cart', 03:44:13 INFO - 'tsvg_static']}, 03:44:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:44:13 INFO - 'talos_options': ['--disable-e10s'], 03:44:13 INFO - 'tests': ['tp5o']}, 03:44:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:44:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:44:13 INFO - 'talos_options': ['--disable-e10s', 03:44:13 INFO - '--xperf_path', 03:44:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:44:13 INFO - 'tests': ['tp5n']}, 03:44:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:44:13 INFO - 'talos_options': ['--xperf_path', 03:44:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:44:13 INFO - 'tests': ['tp5n']}}, 03:44:13 INFO - 'talos.zip': {'path': '', 03:44:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:44:13 INFO - Running post-action listener: _resource_record_post_action 03:44:13 INFO - [mozharness: 2017-04-20 10:44:13.716116Z] Finished populate-webroot step (success) 03:44:13 INFO - [mozharness: 2017-04-20 10:44:13.716228Z] Running create-virtualenv step. 03:44:13 INFO - Running pre-action listener: _resource_record_pre_action 03:44:13 INFO - Running main action method: create_virtualenv 03:44:13 INFO - Creating virtualenv /builds/slave/test/build/venv 03:44: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 03:44:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:44:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:44:13 INFO - Using real prefix '/tools/python27' 03:44:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:44:14 INFO - Installing distribute.............................................................................................................................................................................................done. 03:44:17 INFO - Installing pip.................done. 03:44:17 INFO - Return code: 0 03:44:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:44:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:44:17 INFO - Reading from file tmpfile_stdout 03:44:17 INFO - Output received: 03:44: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) 03:44:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:44:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44: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 0x1025b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc40cb8f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102395d30>, '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 0x1022bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10238abe8>, '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.XDMkKt3QQc/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.TN9sPn0bEf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 03:44: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 03:44: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 03:44:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XDMkKt3QQc/Render', 03:44:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:44:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:44:17 INFO - 'HOME': '/Users/cltbld', 03:44:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:44:17 INFO - 'LOGNAME': 'cltbld', 03:44:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:17 INFO - 'MOZ_NO_REMOTE': '1', 03:44:17 INFO - 'NO_EM_RESTART': '1', 03:44:17 INFO - 'PAGER': '/bin/cat', 03:44:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:44:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:17 INFO - 'PWD': '/builds/slave/test', 03:44:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:44:17 INFO - 'SHELL': '/bin/bash', 03:44:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TN9sPn0bEf/Listeners', 03:44:17 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 03:44:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:44:17 INFO - 'USER': 'cltbld', 03:44:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:44:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:44:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:17 INFO - 'XPC_FLAGS': '0x0', 03:44:17 INFO - 'XPC_SERVICE_NAME': '0', 03:44:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:44:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:18 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 03:44:18 INFO - Cleaning up... 03:44:18 INFO - Return code: 0 03:44:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:44:18 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')]} 03:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:18 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')]} 03:44:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:18 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 0x1025b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc40cb8f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102395d30>, '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 0x1022bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10238abe8>, '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.XDMkKt3QQc/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.TN9sPn0bEf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 03:44:18 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 03:44:18 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 03:44:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XDMkKt3QQc/Render', 03:44:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:44:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:44:18 INFO - 'HOME': '/Users/cltbld', 03:44:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:44:18 INFO - 'LOGNAME': 'cltbld', 03:44:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:18 INFO - 'MOZ_NO_REMOTE': '1', 03:44:18 INFO - 'NO_EM_RESTART': '1', 03:44:18 INFO - 'PAGER': '/bin/cat', 03:44:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:44:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:18 INFO - 'PWD': '/builds/slave/test', 03:44:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:44:18 INFO - 'SHELL': '/bin/bash', 03:44:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TN9sPn0bEf/Listeners', 03:44:18 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 03:44:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:44:18 INFO - 'USER': 'cltbld', 03:44:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:44:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:44:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:18 INFO - 'XPC_FLAGS': '0x0', 03:44:18 INFO - 'XPC_SERVICE_NAME': '0', 03:44:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:44:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:18 INFO - Downloading/unpacking psutil>=3.1.1 03:44: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 03:44: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 03:44: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 03:44: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 03:44: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 03:44: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 03:44:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:44:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:44:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:44:21 INFO - Installing collected packages: psutil 03:44:21 INFO - Running setup.py install for psutil 03:44:21 INFO - building 'psutil._psutil_osx' extension 03:44:21 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 03:44: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 03:44: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 03:44: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 03:44:22 INFO - building 'psutil._psutil_posix' extension 03:44: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 03:44:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:44:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:44:22 INFO - ^ 03:44:22 INFO - 1 warning generated. 03:44:22 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 03:44:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:44:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:44:22 INFO - Successfully installed psutil 03:44:22 INFO - Cleaning up... 03:44:23 INFO - Return code: 0 03:44:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:44: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')]} 03:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44: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')]} 03:44:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44: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 0x1025b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc40cb8f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102395d30>, '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 0x1022bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10238abe8>, '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.XDMkKt3QQc/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.TN9sPn0bEf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 03:44: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 03:44: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 03:44:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XDMkKt3QQc/Render', 03:44:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:44:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:44:23 INFO - 'HOME': '/Users/cltbld', 03:44:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:44:23 INFO - 'LOGNAME': 'cltbld', 03:44:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:23 INFO - 'MOZ_NO_REMOTE': '1', 03:44:23 INFO - 'NO_EM_RESTART': '1', 03:44:23 INFO - 'PAGER': '/bin/cat', 03:44:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:44:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:23 INFO - 'PWD': '/builds/slave/test', 03:44:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:44:23 INFO - 'SHELL': '/bin/bash', 03:44:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TN9sPn0bEf/Listeners', 03:44:23 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 03:44:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:44:23 INFO - 'USER': 'cltbld', 03:44:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:44:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:44:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:23 INFO - 'XPC_FLAGS': '0x0', 03:44:23 INFO - 'XPC_SERVICE_NAME': '0', 03:44:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:44:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:44: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 03:44: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 03:44: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 03:44: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 03:44: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 03:44: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 03:44:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:44:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:44:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:44:25 INFO - Installing collected packages: mozsystemmonitor 03:44:25 INFO - Running setup.py install for mozsystemmonitor 03:44:26 INFO - Successfully installed mozsystemmonitor 03:44:26 INFO - Cleaning up... 03:44:26 INFO - Return code: 0 03:44:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1025b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc40cb8f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102395d30>, '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 0x1022bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10238abe8>, '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.XDMkKt3QQc/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.TN9sPn0bEf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 03:44:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:44:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:44:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XDMkKt3QQc/Render', 03:44:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:44:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:44:27 INFO - 'HOME': '/Users/cltbld', 03:44:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:44:27 INFO - 'LOGNAME': 'cltbld', 03:44:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:27 INFO - 'MOZ_NO_REMOTE': '1', 03:44:27 INFO - 'NO_EM_RESTART': '1', 03:44:27 INFO - 'PAGER': '/bin/cat', 03:44:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:44:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:27 INFO - 'PWD': '/builds/slave/test', 03:44:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:44:27 INFO - 'SHELL': '/bin/bash', 03:44:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TN9sPn0bEf/Listeners', 03:44:27 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 03:44:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:44:27 INFO - 'USER': 'cltbld', 03:44:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:44:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:44:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:27 INFO - 'XPC_FLAGS': '0x0', 03:44:27 INFO - 'XPC_SERVICE_NAME': '0', 03:44:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:44:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:27 INFO - Downloading/unpacking jsonschema==2.5.1 03:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:44:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:44: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 03:44: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 03:44: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 03:44: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 03:44: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 03:44: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 03:44:30 INFO - Downloading functools32-3.2.3-2.tar.gz 03:44:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:44:30 INFO - warning: no files found matching '*.txt' 03:44:30 INFO - no previously-included directories found matching 'build' 03:44:30 INFO - no previously-included directories found matching 'dist' 03:44:30 INFO - no previously-included directories found matching '.git*' 03:44:30 INFO - Installing collected packages: jsonschema, functools32 03:44:30 INFO - Running setup.py install for functools32 03:44:31 INFO - warning: no files found matching '*.txt' 03:44:31 INFO - no previously-included directories found matching 'build' 03:44:31 INFO - no previously-included directories found matching 'dist' 03:44:31 INFO - no previously-included directories found matching '.git*' 03:44:31 INFO - Successfully installed jsonschema functools32 03:44:31 INFO - Cleaning up... 03:44:31 INFO - Return code: 0 03:44:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:44:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1025b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc40cb8f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102395d30>, '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 0x1022bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10238abe8>, '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.XDMkKt3QQc/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.TN9sPn0bEf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 03:44:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:44:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:44:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XDMkKt3QQc/Render', 03:44:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:44:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:44:31 INFO - 'HOME': '/Users/cltbld', 03:44:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:44:31 INFO - 'LOGNAME': 'cltbld', 03:44:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:31 INFO - 'MOZ_NO_REMOTE': '1', 03:44:31 INFO - 'NO_EM_RESTART': '1', 03:44:31 INFO - 'PAGER': '/bin/cat', 03:44:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:44:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:31 INFO - 'PWD': '/builds/slave/test', 03:44:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:44:31 INFO - 'SHELL': '/bin/bash', 03:44:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TN9sPn0bEf/Listeners', 03:44:31 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 03:44:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:44:31 INFO - 'USER': 'cltbld', 03:44:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:44:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:44:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:31 INFO - 'XPC_FLAGS': '0x0', 03:44:31 INFO - 'XPC_SERVICE_NAME': '0', 03:44:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:44:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:44:31 INFO - Cleaning up... 03:44:31 INFO - Return code: 0 03:44:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:44:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1025b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc40cb8f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102395d30>, '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 0x1022bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10238abe8>, '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.XDMkKt3QQc/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.TN9sPn0bEf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 03:44:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:44:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:44:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XDMkKt3QQc/Render', 03:44:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:44:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:44:31 INFO - 'HOME': '/Users/cltbld', 03:44:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:44:31 INFO - 'LOGNAME': 'cltbld', 03:44:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:31 INFO - 'MOZ_NO_REMOTE': '1', 03:44:31 INFO - 'NO_EM_RESTART': '1', 03:44:31 INFO - 'PAGER': '/bin/cat', 03:44:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:44:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:31 INFO - 'PWD': '/builds/slave/test', 03:44:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:44:31 INFO - 'SHELL': '/bin/bash', 03:44:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TN9sPn0bEf/Listeners', 03:44:31 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 03:44:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:44:31 INFO - 'USER': 'cltbld', 03:44:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:44:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:44:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:31 INFO - 'XPC_FLAGS': '0x0', 03:44:31 INFO - 'XPC_SERVICE_NAME': '0', 03:44:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:44:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:31 INFO - Downloading/unpacking blobuploader==1.2.4 03:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:34 INFO - Downloading blobuploader-1.2.4.tar.gz 03:44:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:44:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:44:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:35 INFO - Downloading docopt-0.6.1.tar.gz 03:44:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:44:35 INFO - Installing collected packages: blobuploader, requests, docopt 03:44:35 INFO - Running setup.py install for blobuploader 03:44:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:44:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:44:35 INFO - Running setup.py install for requests 03:44:36 INFO - Running setup.py install for docopt 03:44:36 INFO - Successfully installed blobuploader requests docopt 03:44:36 INFO - Cleaning up... 03:44:36 INFO - Return code: 0 03:44:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:36 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 0x1025b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc40cb8f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102395d30>, '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 0x1022bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10238abe8>, '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.XDMkKt3QQc/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.TN9sPn0bEf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 03:44:36 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 03:44:36 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 03:44:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XDMkKt3QQc/Render', 03:44:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:44:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:44:36 INFO - 'HOME': '/Users/cltbld', 03:44:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:44:36 INFO - 'LOGNAME': 'cltbld', 03:44:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:36 INFO - 'MOZ_NO_REMOTE': '1', 03:44:36 INFO - 'NO_EM_RESTART': '1', 03:44:36 INFO - 'PAGER': '/bin/cat', 03:44:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:44:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:36 INFO - 'PWD': '/builds/slave/test', 03:44:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:44:36 INFO - 'SHELL': '/bin/bash', 03:44:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TN9sPn0bEf/Listeners', 03:44:36 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 03:44:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:44:36 INFO - 'USER': 'cltbld', 03:44:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:44:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:44:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:36 INFO - 'XPC_FLAGS': '0x0', 03:44:36 INFO - 'XPC_SERVICE_NAME': '0', 03:44:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:44:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:44:36 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-Wga4Jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:44:36 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-2feyLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:44:36 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-0WECti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:44:37 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-E2vBBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:44:37 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-7BZ6YX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:44:37 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-qE1AOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:44:37 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-aSOeuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:44:37 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-5SlhNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:44:37 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-6mYAh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:44:37 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-OvSere-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:44:37 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-K1ZV2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:44:37 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-wdlbnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:44:37 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-jAvfan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:44:38 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-oH85HI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:38 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-dygpY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:44:38 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-3B2qKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:44:38 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-PoHbUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:44:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:44:38 INFO - Running setup.py install for manifestparser 03:44:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:44:38 INFO - Running setup.py install for mozcrash 03:44:38 INFO - Running setup.py install for mozdebug 03:44:38 INFO - Running setup.py install for mozdevice 03:44:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:44:39 INFO - Running setup.py install for mozfile 03:44:39 INFO - Running setup.py install for mozhttpd 03:44:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:44:39 INFO - Running setup.py install for mozinfo 03:44:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:44:39 INFO - Running setup.py install for mozInstall 03:44:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:44:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:44:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:44:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:44:39 INFO - Running setup.py install for mozleak 03:44:39 INFO - Running setup.py install for mozlog 03:44:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:44:39 INFO - Running setup.py install for moznetwork 03:44:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:44:40 INFO - Running setup.py install for mozprocess 03:44:40 INFO - Running setup.py install for mozprofile 03:44:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:44:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:44:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:44:40 INFO - Running setup.py install for mozrunner 03:44:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:44:40 INFO - Running setup.py install for mozscreenshot 03:44:40 INFO - Running setup.py install for moztest 03:44:40 INFO - Running setup.py install for mozversion 03:44:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:44:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:44:40 INFO - Cleaning up... 03:44:41 INFO - Return code: 0 03:44:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:41 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 0x1025b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc40cb8f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102395d30>, '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 0x1022bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10238abe8>, '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.XDMkKt3QQc/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.TN9sPn0bEf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 03:44:41 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 03:44:41 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 03:44:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XDMkKt3QQc/Render', 03:44:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:44:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:44:41 INFO - 'HOME': '/Users/cltbld', 03:44:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:44:41 INFO - 'LOGNAME': 'cltbld', 03:44:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:41 INFO - 'MOZ_NO_REMOTE': '1', 03:44:41 INFO - 'NO_EM_RESTART': '1', 03:44:41 INFO - 'PAGER': '/bin/cat', 03:44:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:44:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:41 INFO - 'PWD': '/builds/slave/test', 03:44:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:44:41 INFO - 'SHELL': '/bin/bash', 03:44:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TN9sPn0bEf/Listeners', 03:44:41 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 03:44:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:44:41 INFO - 'USER': 'cltbld', 03:44:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:44:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:44:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:41 INFO - 'XPC_FLAGS': '0x0', 03:44:41 INFO - 'XPC_SERVICE_NAME': '0', 03:44:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:44:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:44:41 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-U8VFAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:44:41 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)) 03:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:44:41 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-XIHt6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:44:41 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)) 03:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:44:41 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-SZUVjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:44:41 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)) 03:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:44:41 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-Ijvgfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:44:41 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)) 03:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:44:41 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-ly1qxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:44: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)) 03:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:44:41 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-5H7GNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:44: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)) 03:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:44:41 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-RQ5VIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:44:42 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)) 03:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:44:42 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-uNoMhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:44:42 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)) 03:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:44:42 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-3sVvri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:44:42 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)) 03:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:44:42 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-UG1qNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:44:42 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)) 03:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:44:42 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-Jo3jrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:44:42 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)) 03:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:44:42 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-t2AnUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:44:42 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)) 03:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:44:42 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-SkpVCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:44:42 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)) 03:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:44:42 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-yTHDU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:44: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)) 03:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:44:42 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-gtVj6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:44: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)) 03:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:44:42 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-0eETQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:44: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)) 03:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:44:42 INFO - Running setup.py (path:/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/pip-FOSC8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:44:43 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)) 03:44:43 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)) 03:44:43 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)) 03:44:43 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)) 03:44:43 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)) 03:44:43 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)) 03:44:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:44:43 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 03:44:43 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 03:44:43 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 03:44:43 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 03:44:43 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 03:44:43 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 03:44:45 INFO - Downloading blessings-1.6.tar.gz 03:44:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:44:45 INFO - Installing collected packages: blessings 03:44:45 INFO - Running setup.py install for blessings 03:44:45 INFO - Successfully installed blessings 03:44:45 INFO - Cleaning up... 03:44:46 INFO - Return code: 0 03:44:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:44:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:44:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:44:46 INFO - Reading from file tmpfile_stdout 03:44:46 INFO - Current package versions: 03:44:46 INFO - blessings == 1.6 03:44:46 INFO - blobuploader == 1.2.4 03:44:46 INFO - docopt == 0.6.1 03:44:46 INFO - functools32 == 3.2.3-2 03:44:46 INFO - jsonschema == 2.5.1 03:44:46 INFO - manifestparser == 1.1 03:44:46 INFO - mozInstall == 1.12 03:44:46 INFO - mozcrash == 1.0 03:44:46 INFO - mozdebug == 0.1 03:44:46 INFO - mozdevice == 0.50 03:44:46 INFO - mozfile == 1.2 03:44:46 INFO - mozhttpd == 0.7 03:44:46 INFO - mozinfo == 0.9 03:44:46 INFO - mozleak == 0.1 03:44:46 INFO - mozlog == 3.4 03:44:46 INFO - moznetwork == 0.27 03:44:46 INFO - mozprocess == 0.25 03:44:46 INFO - mozprofile == 0.28 03:44:46 INFO - mozrunner == 6.13 03:44:46 INFO - mozscreenshot == 0.1 03:44:46 INFO - mozsystemmonitor == 0.3 03:44:46 INFO - moztest == 0.8 03:44:46 INFO - mozversion == 1.4 03:44:46 INFO - psutil == 3.1.1 03:44:46 INFO - requests == 1.2.3 03:44:46 INFO - wsgiref == 0.1.2 03:44:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44:46 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')]} 03:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:46 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')]} 03:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:46 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 0x1025b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc40cb8f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102395d30>, '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 0x1022bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10238abe8>, '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.XDMkKt3QQc/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.TN9sPn0bEf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 03:44:46 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 03:44:46 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 03:44:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XDMkKt3QQc/Render', 03:44:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:44:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:44:46 INFO - 'HOME': '/Users/cltbld', 03:44:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:44:46 INFO - 'LOGNAME': 'cltbld', 03:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:46 INFO - 'MOZ_NO_REMOTE': '1', 03:44:46 INFO - 'NO_EM_RESTART': '1', 03:44:46 INFO - 'PAGER': '/bin/cat', 03:44:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:46 INFO - 'PWD': '/builds/slave/test', 03:44:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:44:46 INFO - 'SHELL': '/bin/bash', 03:44:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TN9sPn0bEf/Listeners', 03:44:46 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 03:44:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:44:46 INFO - 'USER': 'cltbld', 03:44:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:44:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:46 INFO - 'XPC_FLAGS': '0x0', 03:44:46 INFO - 'XPC_SERVICE_NAME': '0', 03:44:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:44:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:46 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)) 03:44:46 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)) 03:44:46 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)) 03:44:46 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)) 03:44:46 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)) 03:44:46 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)) 03:44:46 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)) 03:44:46 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)) 03:44:46 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)) 03:44:46 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)) 03:44:46 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)) 03:44:46 INFO - Cleaning up... 03:44:46 INFO - Return code: 0 03:44:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:44:46 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')]} 03:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:46 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')]} 03:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:46 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 0x1025b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc40cb8f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102395d30>, '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 0x1022bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10238abe8>, '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.XDMkKt3QQc/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.TN9sPn0bEf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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 03:44:46 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 03:44:46 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 03:44:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XDMkKt3QQc/Render', 03:44:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:44:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:44:46 INFO - 'HOME': '/Users/cltbld', 03:44:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:44:46 INFO - 'LOGNAME': 'cltbld', 03:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:46 INFO - 'MOZ_NO_REMOTE': '1', 03:44:46 INFO - 'NO_EM_RESTART': '1', 03:44:46 INFO - 'PAGER': '/bin/cat', 03:44:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:46 INFO - 'PWD': '/builds/slave/test', 03:44:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:44:46 INFO - 'SHELL': '/bin/bash', 03:44:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TN9sPn0bEf/Listeners', 03:44:46 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 03:44:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:44:46 INFO - 'USER': 'cltbld', 03:44:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:44:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:46 INFO - 'XPC_FLAGS': '0x0', 03:44:46 INFO - 'XPC_SERVICE_NAME': '0', 03:44:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:44:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:44:46 INFO - Cleaning up... 03:44:46 INFO - Return code: 0 03:44:46 INFO - Running post-action listener: _resource_record_post_action 03:44:46 INFO - Running post-action listener: _start_resource_monitoring 03:44:46 INFO - Starting resource monitoring. 03:44:46 INFO - [mozharness: 2017-04-20 10:44:46.862661Z] Finished create-virtualenv step (success) 03:44:46 INFO - [mozharness: 2017-04-20 10:44:46.863612Z] Running install step. 03:44:46 INFO - Running pre-action listener: _resource_record_pre_action 03:44:46 INFO - Running main action method: install 03:44:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:44:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:44:47 INFO - Reading from file tmpfile_stdout 03:44:47 INFO - Detecting whether we're running mozinstall >=1.0... 03:44:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:44:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:44:47 INFO - Reading from file tmpfile_stdout 03:44:47 INFO - Output received: 03:44:47 INFO - Usage: mozinstall [options] installer 03:44:47 INFO - Options: 03:44:47 INFO - -h, --help show this help message and exit 03:44:47 INFO - -d DEST, --destination=DEST 03:44:47 INFO - Directory to install application into. [default: 03:44:47 INFO - "/builds/slave/test"] 03:44:47 INFO - --app=APP Application being installed. [default: firefox] 03:44:47 INFO - mkdir: /builds/slave/test/build/application 03:44:47 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'] 03:44:47 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 03:45:06 INFO - Reading from file tmpfile_stdout 03:45:06 INFO - Output received: 03:45:06 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:45:06 INFO - Running post-action listener: _resource_record_post_action 03:45:06 INFO - [mozharness: 2017-04-20 10:45:06.775840Z] Finished install step (success) 03:45:06 INFO - [mozharness: 2017-04-20 10:45:06.775983Z] Running run-tests step. 03:45:06 INFO - Running pre-action listener: _resource_record_pre_action 03:45:06 INFO - Running main action method: run_tests 03:45:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:45:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:45:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:45:06 INFO - 2017-04-20 03:45:06.790 screenresolution[1623:7293] starting screenresolution argv=screenresolution get 03:45:06 INFO - 2017-04-20 03:45:06.792 screenresolution[1623:7293] Display 0: 1600x1200x32@60 03:45:06 INFO - 2017-04-20 03:45:06.798 screenresolution[1624:7296] starting screenresolution argv=screenresolution list 03:45:06 INFO - Available Modes on Display 0 03:45:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:45:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:45:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:45:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:45:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:45:07 INFO - Intel Iris: 03:45:07 INFO - Chipset Model: Intel Iris 03:45:07 INFO - Type: GPU 03:45:07 INFO - Bus: Built-In 03:45:07 INFO - VRAM (Dynamic, Max): 1536 MB 03:45:07 INFO - Vendor: Intel (0x8086) 03:45:07 INFO - Device ID: 0x0a2e 03:45:07 INFO - Revision ID: 0x0009 03:45:07 INFO - Displays: 03:45:07 INFO - Display: 03:45:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:45:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:45:07 INFO - Display Serial Number: 1600x1200 60 03:45:07 INFO - Main Display: Yes 03:45:07 INFO - Mirror: Off 03:45:07 INFO - Online: Yes 03:45:07 INFO - Rotation: Supported 03:45:07 INFO - Return code: 0 03:45:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:45:07 INFO - Python 2.7.3 03:45:07 INFO - Return code: 0 03:45:07 INFO - grabbing minidump binary from tooltool 03:45:07 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')]} 03:45:07 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 0x102395d30>, '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 0x1022bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10238abe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:45:07 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 03:45:07 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 03:45:07 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 03:45:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:45:07 INFO - Return code: 0 03:45:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:45:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:45:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:45:07 INFO - ENV: RUST_BACKTRACE is now 1 03:45:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:45:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:45:07 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/TYjExR9nTrahq3TTfwGFEA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0338', '--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 03:45:07 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/TYjExR9nTrahq3TTfwGFEA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0338 --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 03:45:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XDMkKt3QQc/Render', 03:45:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:45:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:45:07 INFO - 'HOME': '/Users/cltbld', 03:45:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:45:07 INFO - 'LOGNAME': 'cltbld', 03:45:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:45:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:07 INFO - 'MOZ_NO_REMOTE': '1', 03:45:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:45:07 INFO - 'NO_EM_RESTART': '1', 03:45:07 INFO - 'PAGER': '/bin/cat', 03:45:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:07 INFO - 'PWD': '/builds/slave/test', 03:45:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:45:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:45:07 INFO - 'RUST_BACKTRACE': '1', 03:45:07 INFO - 'SHELL': '/bin/bash', 03:45:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TN9sPn0bEf/Listeners', 03:45:07 INFO - 'TMPDIR': '/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/', 03:45:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:45:07 INFO - 'USER': 'cltbld', 03:45:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:45:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:07 INFO - 'XPC_FLAGS': '0x0', 03:45:07 INFO - 'XPC_SERVICE_NAME': '0', 03:45:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:45:07 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/TYjExR9nTrahq3TTfwGFEA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0338', '--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 03:45:07 INFO - mozversion application_buildid: 20170420021428 03:45:07 INFO - mozversion application_changeset: 27311156637f9b5d4504373967e01c4241902ae7 03:45:07 INFO - mozversion application_display_name: Nightly 03:45:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:45:07 INFO - mozversion application_name: Firefox 03:45:07 INFO - mozversion application_remotingname: firefox 03:45:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:45:07 INFO - mozversion application_vendor: Mozilla 03:45:07 INFO - mozversion application_version: 55.0a1 03:45:07 INFO - mozversion platform_buildid: 20170420021428 03:45:07 INFO - mozversion platform_changeset: 27311156637f9b5d4504373967e01c4241902ae7 03:45:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:45:07 INFO - mozversion platform_version: 55.0a1 03:45:07 INFO - using testdate: 1492685107 03:45:07 INFO - actual date: 1492685107 03:45:07 INFO - starting webserver on 'localhost:49241' 03:45:07 INFO - SUITE-START | Running 2 tests 03:45:07 INFO - TEST-START | dromaeo_css 03:45:07 INFO - operating with platform_type : mac_ 03:45:07 INFO - Initialising browser for dromaeo_css test... 03:45:07 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmp5VJRU9/profile http://localhost:49241/getInfo.html) 03:45:10 INFO - PID 1634 | __metrics Screen width/height:1600/1200 03:45:10 INFO - PID 1634 | colorDepth:24 03:45:10 INFO - PID 1634 | Browser inner width/height: 1024/689 03:45:10 INFO - PID 1634 | __metrics 03:45:10 INFO - PID 1634 | 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" 03:45:10 INFO - PID 1634 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:45:11 INFO - TEST-INFO | 1634: exit 0 03:45:11 INFO - Browser initialized. 03:45:11 INFO - Running cycle 1/1 for dromaeo_css test... 03:45:11 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmp5VJRU9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:23 INFO - PID 1635 | RSS: Main: 241217536 03:45:23 INFO - PID 1635 | 03:48:27 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 03:48:29 INFO - PID 1635 | RSS: Main: 394334208 03:48:29 INFO - PID 1635 | 03:50:12 INFO - PID 1635 | ************************* 03:50:12 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 03:50:12 INFO - PID 1635 | 03:50:12 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:50:12 INFO - PID 1635 | Full stack: 03:50:12 INFO - PID 1635 | ************************* 03:50:12 INFO - PID 1635 | ************************* 03:50:12 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 03:50:12 INFO - PID 1635 | 03:50:12 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:50:12 INFO - PID 1635 | Full stack: 03:50:12 INFO - PID 1635 | ************************* 03:50:12 INFO - PID 1635 | ************************* 03:50:12 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 03:50:12 INFO - PID 1635 | 03:50:12 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:50:12 INFO - PID 1635 | Full stack: 03:50:12 INFO - PID 1635 | ************************* 03:50:12 INFO - PID 1635 | ************************* 03:50:12 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 03:50:12 INFO - PID 1635 | 03:50:12 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:50:12 INFO - PID 1635 | Full stack: 03:50:12 INFO - PID 1635 | ************************* 03:51:31 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 03:51:32 INFO - PID 1635 | RSS: Main: 368156672 03:51:32 INFO - PID 1635 | 03:54:34 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 03:54:35 INFO - PID 1635 | RSS: Main: 338108416 03:54:35 INFO - PID 1635 | 03:57:37 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 03:57:38 INFO - PID 1635 | RSS: Main: 326127616 03:57:38 INFO - PID 1635 | 04:00:41 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 04:00:42 INFO - PID 1635 | RSS: Main: 328671232 04:00:42 INFO - PID 1635 | 04:03:44 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 04:03:44 INFO - PID 1635 | RSS: Main: 374960128 04:03:44 INFO - PID 1635 | 04:03:44 INFO - PID 1635 | __start_tp_report 04:03:44 INFO - PID 1635 | _x_x_mozilla_page_load 04:03:44 INFO - PID 1635 | _x_x_mozilla_page_load_details 04:03:44 INFO - PID 1635 | |i|pagename|runs| 04:03:44 INFO - PID 1635 | |0;dojo.html;3067.6932306769327;3465.6534346565345;3468.2890007548453;3479.1128262293128;3488.406970814962;5216.713080780555;5799.652020878751;5892.823215303542;5920.171176035358;6092.2384701912315;5882.264716910387;5907.527397808176;5920.703964801764;5923.73343199556;5936.821895343136;4592.897704550909;4834.951650483503;5203.713795741232;5224.791008359661;5246.632735708502;5278.551323137519;5283.07546179417;5290.232916227144;5291.126964050927;5297.390800057985;5270.604704647148;5283.498067683564;5286.31277933868;5291.894162116755;5292.523672869441;5279.260903473517;5282.550983166436;5292.867678308035;5293.788248470057;5294.814681486168;5129.384473863161;5229.50319719626;5233.921491177635;5248.0553500369915;5282.762275697564;6135.110408990671;6165.10605962133;6167.5682702210415;6170.7223174957235;6190.102435146923;6279.937200627981;6347.523935704794;6353.745850165988;6369.554131210817;6374.617522948638;5080.611823067383;6360.840978975562;6373.3945275198785;6383.808485745435;6468.967655161741;6179.5674302798825;6186.56694031418;6188.257409110935;6192.504599632064;6197.25632924052;6634.601923884582;6651.567648102858;6654.83362915931;6662.333766623299;6681.265060843303;6209.348018458088;6277.654728989949;6295.622262664255;6339.96830015847;6353.841153971095;6434.067060276234;6483.610983341015;6505.772297969548;6509.1863517060365;6513.153290072355;6360.300366959631;6388.904166437507;6428.903566446507;6432.06735023419;6432.9678351607945;6340.968295158495;6420.876346639319;6435.259945106279;6437.130987316652;6446.161998940202;5022.723750193774;5111.8722031948755;5114.641975061784;5144.176931690911;5207.921881171786;4629.537046295343;4630.768461576908;4642.442906851199;4650.86047418578;4685.320628508847;6052.878942421127;6081.300650425169;6101.481374083164;6105.450509454082;6114.449699527064;6303.023031430135;6370.522210834206;6482.57863238888;6527.836804079841;6528.249251336062;6052.697365131726;6090.817275481742;6097.17688112108;6132.448079672851;6135.07973803933;5643.830685079454;5645.5201307888465;5658.292713410824;5658.7170641467765;5661;6392.169018027626;6488.091667166695;6643.7674681385915;6652.667366631746;6669.466442684574;6457.838554036187;6472.644004579794;6500.089987401673;6507.707153178213;6519.185101862267;6651.933480665131;6674.16572928384;6674.16572928384;6675.899861501985;6680.164979377578;5308.362996440452;6368.395002474757;6373.553851230369;6394.360563943568;6403.167588213502;6299.685015749286;6360.96819515918;6372.904406433814;6463.482921366185;6502.772402966063;6227.034809604518;6328.588641738456;6332.651704156316;6360.49116070704;6360.586561873463;5416.431274716098;6229.096780966644;6292.716827742855;6320.494360451061;6347;5171.741412929263;6232.688365581794;6278.748850045947;6278.995360742259;6290.402411770874;5651.237082993907;6106.2061931948565;6247.562670613013;6300.401461861115;6314.273858506147;6090.878182436238;6231.875362492816;6265.27949285838;6266.37336266388;6277.623342599459 04:03:44 INFO - PID 1635 | |1;ext.html;758.7344429449694;798.5328582779074;813.438727278178;1122.2480937771697;1127.560251501915;26470;27031.594526082125;36190.27619447613;36464.81767591165;36506.817465912696;38089;38419.807900960455;38453.80773096137;38479.80760096203;38549.03627409316;8325.167483251687;8510.319174466027;8519.062903080687;8529.10444403338;8529.147085291483;6002.96998515009;6125.877482450348;7889.684412623516;8281.089080201173;8399.37004724645;7488.764353881603;8445.071042185355;8525.701600443987;8525.914740852606;8531.402801803844;8106.959465202695;8473.067962524117;8477.576121193915;8481.067082620906;8485.151484851527;8224.671013159466;8262.504249744974;8267.917320826775;8276.420650554464;8279.710210142677;36347.81826090879;36521.269574608355;36523.81738091292;36535.26929461396;36548.81725591382;3097.984510077435;3570.9821450892578;3572.9285414291567;3573.535440392758;3574.0528759878653;30366.93715719939;30454.695453045406;30469.69530304691;30491.390172196432;30549.694503054907;3092.860821263026;3125.890593829228;3146.7639927005566;3149.3858697553987;3162.0671901788796;206416;283863;284104;284382;290382;47408.5259147411;47417;47545.81135471641;47581.762091189325;47681.523184767706;50145.498545014816;50151;50160.498395016315;50219;50229.74425639388;13303.068785184943;13377.33113344329;13387.799183012263;13410.262435565943;13430.597082087554;10934.015938565568;10963.177761667906;10964.122870170368;10968.670939871816;10971.067459265892;9487.762805929908;10211.846822297672;10236;10261.692149235534;11743.416448381342;5219.973900130475;5272.551833094153;5285.207218917117;5292.20616907467;5293.391260005072;996.5266498413196;1015.4313584392763;1022.223110436074;1032.5921261101973;1067.5356220044305;24142.275731728078;24238.757612424004;29534.55698164529;29925.40149197004;30105.849470752506;1095.4522738630685;1101.7961677089763;1135.103268417957;1136.494260054268;1141.3095077478172;10813.891861081289;12177.208481448677;12332.568360107352;12391.93804030974;12404.8215419535;303495;303518;303932;303984;304556.4772176169;45593.77203113963;45623.77188114038;45669.54330456653;45680.543194568294;46100.3084953726;1441.7621092519826;1456.2500312339155;1499.8725108365693;1506.698660267929;1523.8552337527917;23200.535989279782;23200.76799231986;23208.4197895054;23221;23281.650775238722;35700.285994280486;35787.926362209175;35825.64174358327;35889.46165807567;35992;263166;263628;263925;264054;264303;31302.06093817189;31373.8431307842;31420.842895785376;31454;31520.211994700316;30766.923157689373;39224.607753923236;42109.368359475244;42583.787081064394;43338;25584.616230756183;28656.42687146287;28951.7104828949;29821.10536683903;30103.397932041673;29058.7094129056;29273.414531709674;29929.700702993563;30007.3998520024;30119.698803011688;35945.820270898475;35996.4600530987;36009.09977250485;36046.819765901004;36093.458598120524;26156.08453704111;29842;30122.3975520484;30711.733992855894;30815.383692326475;22784.405091643424;23870.403239919142;24130.87934560316;24203;24230.75769242285 04:03:44 INFO - PID 1635 | |2;jquery.html;382.11996974883573;427.19021310181535;434.0580939361586;441.984530541431;455.0807369114389;17146.91426542867;20707;22235.664650302464;22479.775202248013;22702.77297227027;22368.664470032963;22435;22696.65955010672;22753.54492910145;22771.97526111325;5891.469767720904;5952.7916522921705;6082.482988945922;6166.7533298667995;6185.381461853824;6077.665728384937;6164.044573091178;6184.938150618481;6199.752009919598;6202.162708034402;3635.2547727715755;3665.047087757189;3777.9622203777885;6169.506439484853;6212.81361559154;6105.32841387447;6142.600730952474;6153;6166.8766624667705;6171.981623032172;5343.893122137574;5476.904619076201;5537.335519737617;5539.14143307788;5544.085225937715;26954.865225673748;27426.862865685544;27456.313592160157;27547.449051018866;27690.723092769218;2197.4726065744267;2246.1801442473543;2249.5275992041693;2250.6849041134255;2251.0770584060456;17457.301707931667;18885;19175.90412047945;19692.803071969385;19741.40775776729;2087.634663933821;2282.2126366403563;2299.1493147535352;2312.508432061311;2406.614941609334;151060;153728.92542149095;155735;156258;161407.99999999884;16757.664846703243;17810.76623181876;23135.53728925412;23218.3379484773;23379.766202338098;32071.037868863972;40593.37901362434;41005.384919226235;41231;41321.586784131774;10572.947135264274;10692.62575809843;10774.030337269684;10783.83824242637;10935.398553079656;7552.8867066994035;8424.199701028392;8436.662533498591;8581.313494920516;8609.82780344402;10327.431991240554;11104.279451534265;11125.72185695348;11267.591551056117;11268.887311126948;4242.406063151161;4353.4122893408985;4382.342648602671;4387.082590077626;4447.710898791568;829.78425609342;951.7382719752123;970.2722957781664;982.6806287956442;998.9550470228712;18560.628787424175;19019.953902535493;20474.078666459747;20495;21209;970.1317320997808;971.7862070344513;979.1579241852002;998.3311181508407;1008.1229330482527;10610.363378197333;10973.341599503896;11199.361006414767;12920.769807548113;14081.647958801112;524787.7521224815;525522;533101;539185;546411;133978;134028;134542.32728836488;135207;138150;1208.4139192491634;1215.9635210943686;1234.062112794265;1237.4678888078213;1240.299230934519;21832.89083554572;21851;22188.556228875656;22727.09091636316;23007.53984920259;58266.83466330565;58474;59630.70184649222;59782.701086494286;59923.700381499555;76677.23322766925;76816.84774728272;77303;79984;80622.59688701518;8729.694460693845;8799.47203167812;8803.383763136519;8840.602172902363;8916.55417229149;13657.863421365659;13825.30873456303;13846.446142154202;14254;14279.500217492337;11740.647780566596;11799;11892.524299028288;11935.52257909674;12069.336186509827;10910;10958.726031849268;11063.834042489209;11147.8248753444;11243.550257989917;12120.939395302967;12127.151099422956;12156.209846359958;12225.694357640774;12285.938570307091;8709.91290087091;8874.866876996979;8906.777330566787;8926.241269492166;9200.769980750534;11723.296602203895;11728.472218750347;11982.700432489257;12082.577109801467;12126.090543209471 04:03:44 INFO - PID 1635 | |3;mootools.html;1260.2627462934186;1417.617243344297;1438.3743071763777;1439.3379045639008;1447.811784468019;9614.37506562074;11801.704957376049;11808.940955295222;11832;11862.644120676372;11491.770164596703;11560.017398521115;11711.12166587505;11855.051595872332;11895.940520297387;2169.9891500542476;2512.4095837478226;2544.580144276192;2557.207265747615;2561.2956436979885;2479.76442237988;2490.1533478617266;2553;2554.6678931738847;2560.7311232320617;2466.3464181991785;2563.218218443374;2563.269468201563;2567.717551069381;2570.4345044090364;2509.573372526675;2522.268542122782;2532.3162746058647;2555.4378036831868;2562.8846701898274;2526.8104892133165;2541.212224210482;2546.045233037611;2554.0549996501227;2557.0666706652123;11496.885031149748;11763.529458821637;11766.470508827124;11779.646610601696;11797.941010294979;5170.767315470813;6782.864342713118;6808.6255255960905;6808.931910680879;6813.965930170318;4073.816678249486;4337.97831010846;4350.32569951658;4386.8903277418;4423.933640995388;1208.2448469706433;1228.8095345221504;1249.7063190150307;1304.132751720105;1306.6929271621161;14925.925370373187;15207.391704331814;15584.999999999887;16539.91730041354;16548.75176872348;4690.6012988895645;4918.975405122951;5071.340725705709;6123.663198524124;6137.478314343241;13590.59228223155;13780.173189608455;13788.965827562974;13819.930900345635;13856.792148117785;6769.492288078315;6779.898301525481;6782.694778734969;6824.624645644438;6853.897191542131;6107.7862274821055;6145.293291271471;6254.124422580842;6274.686265686697;6276.843078923063;4621.237495813153;4637.489876113625;4641.582257596765;4698.389209402756;4727.929081063787;1419.396756378535;1448.8406275309708;1451.9128852268898;1473.8820894328428;1475.203390169318;629.7323637454064;735.400648471494;770.3452065744185;780.449782903052;799.3605115907251;5980.073088671176;5997.340292567814;6228.844278893064;6258.968705156445;6322.9051564226575;576.2940398012485;577.9277590301213;596.4125336543501;604.9848753781102;611.4069352727847;3234.5956755405573;3778.905527361838;3907.1794923066473;4233.195692818416;4344.652427805768;13934.163950163023;14252.714945701235;14906.627334316512;14918.538441157087;14951.700965980837;14120.71758564823;14267.929905257148;14575.489857854924;14593.92703036478;14601.78097328541;8127.918720812716;8378.497290162732;8408.83182336362;8421.747347579583;8448.535330556755;6525.911708253313;6548.279689234085;6806.047153398627;6819.386255237053;6924.965375173092;13141.474341026253;13185.142965707199;13389.062765606704;13489.662758431117;13501.257430841399;10616.84074738895;13008.349582520646;13639.113457625223;13736.793948090986;13862.306884655525;9310.998135400921;9560.187384072431;9570.95214523923;9572.952135239279;9579;10443.94778026105;10554;10566.154707623526;10631.521581529005;10640.574377024832;8847.832281091174;8988.10118988096;9075.13786190311;9146.085391461067;9194.586243619187;8725.171108744658;8858.911410885808;8919.55402229899;8927.687530936386;9134.908650913672;8047.0745864226365;8160.918390816016;8173.713920012771;8176.01887773471;8184.140665230065;5922.3485416605;5953.523718102455;6019.097135429721;6111.449969502766;6143.293521245114;5928.170056192051;6002.129691194665;6122.173506576555;6233.2208473940755;6321.178246828067 04:03:44 INFO - PID 1635 | |4;prototype.html;398.5775078416878;402.36828179757777;404.45600667102747;404.80771633474086;413.22314049586794;5287.074761916663;5777.42225777422;5822.592418530699;5827.4463925927075;5851.853703657411;4929.433115191754;5414.78167412332;5601.691906945127;5703.7148142592805;5767.740451679674;4359.193549193394;4364.148990946775;4373.781310934456;4374.693771436001;4378;4346.8702534175345;4359.280718681413;4372;4376.868693939187;4377.824887004516;3997.6202260785326;4115.629593336614;4177.519585247705;4341.413909122275;4367.606915377615;3689.0039689283744;4006.419069234974;4164.354525048622;4171.666266698672;4190.6018928202075;3640.908977275563;3642.1987162824134;3659.634036596319;3683.208110256308;3687.557493100845;5383.407825139231;5454.072807622713;5512.641678290898;5525.392206857243;5597.692126933017;4134.503859536845;4329;4855.8634200951465;4900.828471003533;4926.871436637725;5958.344582095966;5973.761049558012;5984.461398474158;5997.280326360821;5998.520118390518;3472.6527347265323;3936.7992762207514;4126.855560055384;4149.668026557868;4169.374593810922;5014.799408023675;5435.701036442994;6091.756329746805;6258.249010118815;6264.362074133316;4090.2433049885867;4199.265128602482;4205.747655140702;4209.831606735696;4211.7262377945335;3601.423772196436;4258.14770574801;4284.721493102938;4285.207236661227;4298.76356800379;4152.667786577066;4400.779961001937;4667.409587678871;4693.225617773098;4969.633350828551;4425.2520254499295;4793.808247670124;5935.673537955454;6044.063170208625;6059.303180134341;1442.5286208067712;1456.8615981481742;1463.8243410790774;1464.5020692964442;1465.157534417714;925.0340927513561;966.367029595616;977.8239916815041;978.0952618827698;982.7150126463389;5038.874028149326;5105.438401775876;5428.131498960226;5719.28508936383;5792.391798861143;5282.867928301823;5475.4524547544925;5894.440028197314;6241.251049874044;6266.905996410058;5440.483154100354;5512;5635.549156067505;5673.375928647845;5732.541396688255;3265.4855761064323;3267.068885367659;3268.8202148881564;3271.672832716757;3292.93414131716;6179.876402471926;6370.936290637127;6440.261129495104;6490.701859628093;6569.57297775643;6388.840278993062;6393.456556192683;6406.551541392151;6407.807765767035;6434.7104380303;5332.520073193509;6425.775097871646;6436.259830119502;6448.548601597843;6527.67361631926;5901.970490147522;6131.294901086254;6173.228346456693;6196.132541444112;6213.5339849512375;5171.965606878564;5192.844214673566;5230.398504172069;6103.816885493442;6155.553444940525;4806.365835615908;5292.9735351323;6263.592866463665;6407.967960160169;6424.743010279536;3539.7876127431405;3690.3541880170324;4163.938195760183;4170.895727606834;4170.936411215121;5124.615653826053;5440.4015558287765;6047.911375952371;6180.704410434884;6253.468455181361;6066.332703402711;6083.452489275986;6125.173101631222;6146.231721034871;6154.846128846814;5299.602529810357;5384.380796208487;5621.161313536638;6096.542759292982;6155.953487907156;4814.448342378545;5646.096624540054;5651.745671444877;5985.341612422717;6030.396960303934;6063.453819276233;6065.211522502223;6102.755889764359;6103.816885493442;6120.908186377119;5272.499112584298;5541.695206763506;5662.980663480613;5813.186153938367;5933.584649074523 04:03:44 INFO - PID 1635 | |5;yui.html;710.3677726823125;854.8504011797935;857.5669287010058;857.7169534053763;874.8031692869105;12909.870901290984;17596.64806703865;17985.55036124094;18026.09869506526;18032.278708851663;16510.917445412757;16580.08809515479;16610;16626.50120496387;16662.50012499627;948.1182500274741;949.4350861237552;953.6090203016764;954.0554850697829;970.257752819094;943.2312665177892;945.6831961292975;950.4059962523423;950.8383574792302;995.1740055753743;1018.1854516386898;1020.6121673763996;1022.4734261855151;1024.0220589337202;1050.8108540462713;1011.3426272922659;1012.5190534496129;1013.5388398278766;1015.8222311095528;1042.8644276244077;751.2825251884437;754.1478129713444;757.7802437293234;759.8024513626497;778.4084096086958;16119;16148.515544533682;16253.918730406273;16698.749518757228;17002.914985424995;13422.731545369037;16549.172541373002;16886.66226675472;16987;17098.487045388658;13629.591112266648;13746.793798093036;13858.307084645727;13901.652458688613;14071.226082565454;3129.8278594677286;3148;3152.8108313501034;3154.7318477929402;3157.7315928146136;94120.52939735325;118341;126533.36733316275;126714;126788.36605816912;11048.839871813505;11348.432578371048;11379.203455758017;12900.935495322463;13016.958643308702;23872.52254954891;23903.76096239015;24131.63802542963;24504;24926.626100608504;7547.320741133214;7619.885701714478;7632.732854350071;7706.306432420997;7710.9590205321565;3327.8835240766457;3775.301569209705;3843.365844635604;3843.5964223756105;3856.5757766645647;4277.850275240352;4321.178975994551;4325.264705000158;4357.2592659248;4371;812.5774597209418;930.0745757970863;950.7005293332578;951.5765484359393;952.7665721898179;589.375262222046;640.3980258556942;651.947844172465;670.6713710282024;698.9895151572731;11092.389918554558;11864.169648032257;11944.343061131722;11967.820482692767;12080.637580872588;659.120074700271;663.4891133826926;665.6671664167916;675.9560628559128;695.7078027228577;5409.377921539073;5544.91682624761;5564.081926482085;5652.97173514138;5657.2928383952;101214;102961.45557816638;103088;104138.95861041444;106271.46864265784;88977;89901;91925;92462.53768731114;92518.53740731253;79732.08132749642;80172.59913700394;80502.33952078414;80910.5954470224;82670;9639.325247232626;10858.728531786768;11345.319280843176;11417.885821141683;11587.942060289644;39276;39799.80100099481;40235;40770.38844417277;41234.587654123075;51664;52002.73998629983;52008.47991520036;52026.47973520216;52285.43143705695;14005.73948344654;14072.366743496772;14088.436462541384;14260;14326.713465730418;15468.303926323568;15575.610609734847;15680.686386271982;15723.371065157724;15754.684906302038;14314.141151530941;14619.049761765451;14655.92672036633;14818.555443336718;16246.918765406097;16262.105584192983;16341.836581634032;16404;16522.42171523991;16526.256318465938;16420.178991050638;16551.08969006716;16563.751543727096;16604.58488537796;16743.24655390486;11751.882481175078;11781.352025638673;12202.450889709808;12213.572524961939;12771.74456510846;12560.12079154487;13381.330933453093;13510.527131550349;13526.053176277566;13549.729005420033 04:03:44 INFO - PID 1635 | __end_tp_report 04:03:44 INFO - PID 1635 | __start_cc_report 04:03:44 INFO - PID 1635 | _x_x_mozilla_cycle_collect,1484 04:03:44 INFO - PID 1635 | __end_cc_report 04:03:44 INFO - PID 1635 | __startTimestamp1492686224741__endTimestamp 04:03:44 INFO - PID 1635 | 04:03:44 INFO - PID 1635 | ------- Summary: start ------- 04:03:44 INFO - PID 1635 | Number of tests: 6 04:03:44 INFO - PID 1635 | 04:03:44 INFO - PID 1635 | [#0] dojo.html Cycles:165 Average:5924.26 Median:6209.35 stddev:708.13 (11.4%) stddev-sans-first:673.92 04:03:44 INFO - PID 1635 | Values: 3067.7 3465.7 3468.3 3479.1 3488.4 5216.7 5799.7 5892.8 5920.2 6092.2 5882.3 5907.5 5920.7 5923.7 5936.8 4592.9 4835.0 5203.7 5224.8 5246.6 5278.6 5283.1 5290.2 5291.1 5297.4 5270.6 5283.5 5286.3 5291.9 5292.5 5279.3 5282.6 5292.9 5293.8 5294.8 5129.4 5229.5 5233.9 5248.1 5282.8 6135.1 6165.1 6167.6 6170.7 6190.1 6279.9 6347.5 6353.7 6369.6 6374.6 5080.6 6360.8 6373.4 6383.8 6469.0 6179.6 6186.6 6188.3 6192.5 6197.3 6634.6 6651.6 6654.8 6662.3 6681.3 6209.3 6277.7 6295.6 6340.0 6353.8 6434.1 6483.6 6505.8 6509.2 6513.2 6360.3 6388.9 6428.9 6432.1 6433.0 6341.0 6420.9 6435.3 6437.1 6446.2 5022.7 5111.9 5114.6 5144.2 5207.9 4629.5 4630.8 4642.4 4650.9 4685.3 6052.9 6081.3 6101.5 6105.5 6114.4 6303.0 6370.5 6482.6 6527.8 6528.2 6052.7 6090.8 6097.2 6132.4 6135.1 5643.8 5645.5 5658.3 5658.7 5661.0 6392.2 6488.1 6643.8 6652.7 6669.5 6457.8 6472.6 6500.1 6507.7 6519.2 6651.9 6674.2 6674.2 6675.9 6680.2 5308.4 6368.4 6373.6 6394.4 6403.2 6299.7 6361.0 6372.9 6463.5 6502.8 6227.0 6328.6 6332.7 6360.5 6360.6 5416.4 6229.1 6292.7 6320.5 6347.0 5171.7 6232.7 6278.7 6279.0 6290.4 5651.2 6106.2 6247.6 6300.4 6314.3 6090.9 6231.9 6265.3 6266.4 6277.6 04:03:44 INFO - PID 1635 | 04:03:44 INFO - PID 1635 | [#1] ext.html Cycles:180 Average:42450.85 Median:17213.98 stddev:73449.85 (426.7%) stddev-sans-first:73589.19 04:03:44 INFO - PID 1635 | Values: 758.7 798.5 813.4 1122.2 1127.6 26470.0 27031.6 36190.3 36464.8 36506.8 38089.0 38419.8 38453.8 38479.8 38549.0 8325.2 8510.3 8519.1 8529.1 8529.1 6003.0 6125.9 7889.7 8281.1 8399.4 7488.8 8445.1 8525.7 8525.9 8531.4 8107.0 8473.1 8477.6 8481.1 8485.2 8224.7 8262.5 8267.9 8276.4 8279.7 36347.8 36521.3 36523.8 36535.3 36548.8 3098.0 3571.0 3572.9 3573.5 3574.1 30366.9 30454.7 30469.7 30491.4 30549.7 3092.9 3125.9 3146.8 3149.4 3162.1 206416.0 283863.0 284104.0 284382.0 290382.0 47408.5 47417.0 47545.8 47581.8 47681.5 50145.5 50151.0 50160.5 50219.0 50229.7 13303.1 13377.3 13387.8 13410.3 13430.6 10934.0 10963.2 10964.1 10968.7 10971.1 9487.8 10211.8 10236.0 10261.7 11743.4 5220.0 5272.6 5285.2 5292.2 5293.4 996.5 1015.4 1022.2 1032.6 1067.5 24142.3 24238.8 29534.6 29925.4 30105.8 1095.5 1101.8 1135.1 1136.5 1141.3 10813.9 12177.2 12332.6 12391.9 12404.8 303495.0 303518.0 303932.0 303984.0 304556.5 45593.8 45623.8 45669.5 45680.5 46100.3 1441.8 1456.3 1499.9 1506.7 1523.9 23200.5 23200.8 23208.4 23221.0 23281.7 35700.3 35787.9 35825.6 35889.5 35992.0 263166.0 263628.0 263925.0 264054.0 264303.0 31302.1 31373.8 31420.8 31454.0 31520.2 30766.9 39224.6 42109.4 42583.8 43338.0 25584.6 28656.4 28951.7 29821.1 30103.4 29058.7 29273.4 29929.7 30007.4 30119.7 35945.8 35996.5 36009.1 36046.8 36093.5 26156.1 29842.0 30122.4 30711.7 30815.4 22784.4 23870.4 24130.9 24203.0 24230.8 04:03:44 INFO - PID 1635 | 04:03:44 INFO - PID 1635 | [#2] jquery.html Cycles:180 Average:36566.77 Median:12660.02 stddev:90859.83 (717.7%) stddev-sans-first:91074.09 04:03:44 INFO - PID 1635 | Values: 382.1 427.2 434.1 442.0 455.1 17146.9 20707.0 22235.7 22479.8 22702.8 22368.7 22435.0 22696.7 22753.5 22772.0 5891.5 5952.8 6082.5 6166.8 6185.4 6077.7 6164.0 6184.9 6199.8 6202.2 3635.3 3665.0 3778.0 6169.5 6212.8 6105.3 6142.6 6153.0 6166.9 6172.0 5343.9 5476.9 5537.3 5539.1 5544.1 26954.9 27426.9 27456.3 27547.4 27690.7 2197.5 2246.2 2249.5 2250.7 2251.1 17457.3 18885.0 19175.9 19692.8 19741.4 2087.6 2282.2 2299.1 2312.5 2406.6 151060.0 153728.9 155735.0 156258.0 161408.0 16757.7 17810.8 23135.5 23218.3 23379.8 32071.0 40593.4 41005.4 41231.0 41321.6 10572.9 10692.6 10774.0 10783.8 10935.4 7552.9 8424.2 8436.7 8581.3 8609.8 10327.4 11104.3 11125.7 11267.6 11268.9 4242.4 4353.4 4382.3 4387.1 4447.7 829.8 951.7 970.3 982.7 999.0 18560.6 19020.0 20474.1 20495.0 21209.0 970.1 971.8 979.2 998.3 1008.1 10610.4 10973.3 11199.4 12920.8 14081.6 524787.8 525522.0 533101.0 539185.0 546411.0 133978.0 134028.0 134542.3 135207.0 138150.0 1208.4 1216.0 1234.1 1237.5 1240.3 21832.9 21851.0 22188.6 22727.1 23007.5 58266.8 58474.0 59630.7 59782.7 59923.7 76677.2 76816.8 77303.0 79984.0 80622.6 8729.7 8799.5 8803.4 8840.6 8916.6 13657.9 13825.3 13846.4 14254.0 14279.5 11740.6 11799.0 11892.5 11935.5 12069.3 10910.0 10958.7 11063.8 11147.8 11243.6 12120.9 12127.2 12156.2 12225.7 12285.9 8709.9 8874.9 8906.8 8926.2 9200.8 11723.3 11728.5 11982.7 12082.6 12126.1 04:03:44 INFO - PID 1635 | 04:03:44 INFO - PID 1635 | [#3] mootools.html Cycles:180 Average:7086.05 Median:3843.04 stddev:4461.61 (116.1%) stddev-sans-first:4452.64 04:03:44 INFO - PID 1635 | Values: 1260.3 1417.6 1438.4 1439.3 1447.8 9614.4 11801.7 11808.9 11832.0 11862.6 11491.8 11560.0 11711.1 11855.1 11895.9 2170.0 2512.4 2544.6 2557.2 2561.3 2479.8 2490.2 2553.0 2554.7 2560.7 2466.3 2563.2 2563.3 2567.7 2570.4 2509.6 2522.3 2532.3 2555.4 2562.9 2526.8 2541.2 2546.0 2554.1 2557.1 11496.9 11763.5 11766.5 11779.6 11797.9 5170.8 6782.9 6808.6 6808.9 6814.0 4073.8 4338.0 4350.3 4386.9 4423.9 1208.2 1228.8 1249.7 1304.1 1306.7 14925.9 15207.4 15585.0 16539.9 16548.8 4690.6 4919.0 5071.3 6123.7 6137.5 13590.6 13780.2 13789.0 13819.9 13856.8 6769.5 6779.9 6782.7 6824.6 6853.9 6107.8 6145.3 6254.1 6274.7 6276.8 4621.2 4637.5 4641.6 4698.4 4727.9 1419.4 1448.8 1451.9 1473.9 1475.2 629.7 735.4 770.3 780.4 799.4 5980.1 5997.3 6228.8 6259.0 6322.9 576.3 577.9 596.4 605.0 611.4 3234.6 3778.9 3907.2 4233.2 4344.7 13934.2 14252.7 14906.6 14918.5 14951.7 14120.7 14267.9 14575.5 14593.9 14601.8 8127.9 8378.5 8408.8 8421.7 8448.5 6525.9 6548.3 6806.0 6819.4 6925.0 13141.5 13185.1 13389.1 13489.7 13501.3 10616.8 13008.3 13639.1 13736.8 13862.3 9311.0 9560.2 9571.0 9573.0 9579.0 10443.9 10554.0 10566.2 10631.5 10640.6 8847.8 8988.1 9075.1 9146.1 9194.6 8725.2 8858.9 8919.6 8927.7 9134.9 8047.1 8160.9 8173.7 8176.0 8184.1 5922.3 5953.5 6019.1 6111.4 6143.3 5928.2 6002.1 6122.2 6233.2 6321.2 04:03:44 INFO - PID 1635 | 04:03:44 INFO - PID 1635 | [#4] prototype.html Cycles:180 Average:4849.10 Median:5421.46 stddev:1489.33 (27.5%) stddev-sans-first:1455.56 04:03:44 INFO - PID 1635 | Values: 398.6 402.4 404.5 404.8 413.2 5287.1 5777.4 5822.6 5827.4 5851.9 4929.4 5414.8 5601.7 5703.7 5767.7 4359.2 4364.1 4373.8 4374.7 4378.0 4346.9 4359.3 4372.0 4376.9 4377.8 3997.6 4115.6 4177.5 4341.4 4367.6 3689.0 4006.4 4164.4 4171.7 4190.6 3640.9 3642.2 3659.6 3683.2 3687.6 5383.4 5454.1 5512.6 5525.4 5597.7 4134.5 4329.0 4855.9 4900.8 4926.9 5958.3 5973.8 5984.5 5997.3 5998.5 3472.7 3936.8 4126.9 4149.7 4169.4 5014.8 5435.7 6091.8 6258.2 6264.4 4090.2 4199.3 4205.7 4209.8 4211.7 3601.4 4258.1 4284.7 4285.2 4298.8 4152.7 4400.8 4667.4 4693.2 4969.6 4425.3 4793.8 5935.7 6044.1 6059.3 1442.5 1456.9 1463.8 1464.5 1465.2 925.0 966.4 977.8 978.1 982.7 5038.9 5105.4 5428.1 5719.3 5792.4 5282.9 5475.5 5894.4 6241.3 6266.9 5440.5 5512.0 5635.5 5673.4 5732.5 3265.5 3267.1 3268.8 3271.7 3292.9 6179.9 6370.9 6440.3 6490.7 6569.6 6388.8 6393.5 6406.6 6407.8 6434.7 5332.5 6425.8 6436.3 6448.5 6527.7 5902.0 6131.3 6173.2 6196.1 6213.5 5172.0 5192.8 5230.4 6103.8 6155.6 4806.4 5293.0 6263.6 6408.0 6424.7 3539.8 3690.4 4163.9 4170.9 4170.9 5124.6 5440.4 6047.9 6180.7 6253.5 6066.3 6083.5 6125.2 6146.2 6154.8 5299.6 5384.4 5621.2 6096.5 6156.0 4814.4 5646.1 5651.7 5985.3 6030.4 6063.5 6065.2 6102.8 6103.8 6120.9 5272.5 5541.7 5663.0 5813.2 5933.6 04:03:44 INFO - PID 1635 | 04:03:44 INFO - PID 1635 | [#5] yui.html Cycles:180 Average:21126.88 Median:18005.82 stddev:29888.68 (166.0%) stddev-sans-first:29933.21 04:03:44 INFO - PID 1635 | Values: 710.4 854.9 857.6 857.7 874.8 12909.9 17596.6 17985.6 18026.1 18032.3 16510.9 16580.1 16610.0 16626.5 16662.5 948.1 949.4 953.6 954.1 970.3 943.2 945.7 950.4 950.8 995.2 1018.2 1020.6 1022.5 1024.0 1050.8 1011.3 1012.5 1013.5 1015.8 1042.9 751.3 754.1 757.8 759.8 778.4 16119.0 16148.5 16253.9 16698.7 17002.9 13422.7 16549.2 16886.7 16987.0 17098.5 13629.6 13746.8 13858.3 13901.7 14071.2 3129.8 3148.0 3152.8 3154.7 3157.7 94120.5 118341.0 126533.4 126714.0 126788.4 11048.8 11348.4 11379.2 12900.9 13017.0 23872.5 23903.8 24131.6 24504.0 24926.6 7547.3 7619.9 7632.7 7706.3 7711.0 3327.9 3775.3 3843.4 3843.6 3856.6 4277.9 4321.2 4325.3 4357.3 4371.0 812.6 930.1 950.7 951.6 952.8 589.4 640.4 651.9 670.7 699.0 11092.4 11864.2 11944.3 11967.8 12080.6 659.1 663.5 665.7 676.0 695.7 5409.4 5544.9 5564.1 5653.0 5657.3 101214.0 102961.5 103088.0 104139.0 106271.5 88977.0 89901.0 91925.0 92462.5 92518.5 79732.1 80172.6 80502.3 80910.6 82670.0 9639.3 10858.7 11345.3 11417.9 11587.9 39276.0 39799.8 40235.0 40770.4 41234.6 51664.0 52002.7 52008.5 52026.5 52285.4 14005.7 14072.4 14088.4 14260.0 14326.7 15468.3 15575.6 15680.7 15723.4 15754.7 14314.1 14619.0 14655.9 14818.6 16246.9 16262.1 16341.8 16404.0 16522.4 16526.3 16420.2 16551.1 16563.8 16604.6 16743.2 11751.9 11781.4 12202.5 12213.6 12771.7 12560.1 13381.3 13510.5 13526.1 13549.7 04:03:44 INFO - PID 1635 | -------- Summary: end -------- 04:03:44 INFO - PID 1635 | 04:03:45 INFO - TEST-INFO | 1635: exit 0 04:03:45 INFO - TEST-OK | dromaeo_css | took 1118071ms 04:03:45 INFO - TEST-START | kraken 04:03:45 INFO - operating with platform_type : mac_ 04:03:45 INFO - Initialising browser for kraken test... 04:03:45 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmp8wnUNU/profile http://localhost:49241/getInfo.html) 04:03:47 INFO - PID 1648 | __metrics Screen width/height:1600/1200 04:03:47 INFO - PID 1648 | colorDepth:24 04:03:47 INFO - PID 1648 | Browser inner width/height: 1024/689 04:03:47 INFO - PID 1648 | __metrics 04:03:47 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" 04:03:47 INFO - PID 1648 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:03:48 INFO - TEST-INFO | 1648: exit 0 04:03:48 INFO - Browser initialized. 04:03:48 INFO - Running cycle 1/1 for kraken test... 04:03:48 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/T/tmp8wnUNU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:04:01 INFO - PID 1649 | RSS: Main: 241283072 04:04:01 INFO - PID 1649 | 04:04:03 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 04:04:04 INFO - PID 1649 | RSS: Main: 311779328 04:04:04 INFO - PID 1649 | 04:04:07 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 04:04:08 INFO - PID 1649 | RSS: Main: 292843520 04:04:08 INFO - PID 1649 | 04:04:11 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 04:04:11 INFO - PID 1649 | RSS: Main: 384815104 04:04:11 INFO - PID 1649 | 04:04:13 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 04:04:14 INFO - PID 1649 | RSS: Main: 287731712 04:04:14 INFO - PID 1649 | 04:04:16 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:04:17 INFO - PID 1649 | RSS: Main: 290185216 04:04:17 INFO - PID 1649 | 04:04:19 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 04:04:20 INFO - PID 1649 | RSS: Main: 353898496 04:04:20 INFO - PID 1649 | 04:04:23 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 04:04:24 INFO - PID 1649 | RSS: Main: 373325824 04:04:24 INFO - PID 1649 | 04:04:27 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 04:04:27 INFO - PID 1649 | RSS: Main: 382459904 04:04:27 INFO - PID 1649 | 04:04:29 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:04:29 INFO - PID 1649 | RSS: Main: 332423168 04:04:29 INFO - PID 1649 | 04:04:31 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:04:32 INFO - PID 1649 | RSS: Main: 334184448 04:04:32 INFO - PID 1649 | 04:04:34 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:04:35 INFO - PID 1649 | RSS: Main: 318197760 04:04:35 INFO - PID 1649 | 04:04:37 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:04:38 INFO - PID 1649 | RSS: Main: 351522816 04:04:38 INFO - PID 1649 | 04:04:41 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:04:42 INFO - PID 1649 | RSS: Main: 344178688 04:04:42 INFO - PID 1649 | 04:04:44 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 04:04:44 INFO - PID 1649 | RSS: Main: 386838528 04:04:44 INFO - PID 1649 | 04:04:44 INFO - PID 1649 | __start_tp_report 04:04:44 INFO - PID 1649 | _x_x_mozilla_page_load 04:04:44 INFO - PID 1649 | _x_x_mozilla_page_load_details 04:04:44 INFO - PID 1649 | |i|pagename|runs| 04:04:44 INFO - PID 1649 | |0;ai-astar;110;109;109;111;110;111;111;111;110;110 04:04:44 INFO - PID 1649 | |1;audio-beat-detection;142;108;105;154;140;142;136;104;134;110 04:04:44 INFO - PID 1649 | |2;audio-dft;185;183;186;182;181;184;187;182;185;181 04:04:44 INFO - PID 1649 | |3;audio-fft;80;58;59;85;49;76;88;86;84;58 04:04:44 INFO - PID 1649 | |4;audio-oscillator;94;68;85;69;69;66;89;68;68;91 04:04:44 INFO - PID 1649 | |5;imaging-gaussian-blur;85;86;86;86;87;87;87;85;87;87 04:04:44 INFO - PID 1649 | |6;imaging-darkroom;93;95;95;95;94;94;94;101;135;93 04:04:44 INFO - PID 1649 | |7;imaging-desaturate;86;88;83;85;86;83;90;116;85;100 04:04:44 INFO - PID 1649 | |8;json-parse-financial;50;47;46;47;47;48;48;48;48;47 04:04:44 INFO - PID 1649 | |9;json-stringify-tinderbox;53;55;59;66;62;61;70;76;77;78 04:04:44 INFO - PID 1649 | |10;stanford-crypto-aes;81;82;83;83;81;82;83;83;81;80 04:04:44 INFO - PID 1649 | |11;stanford-crypto-ccm;139;138;137;141;134;139;141;136;174;153 04:04:44 INFO - PID 1649 | |12;stanford-crypto-pbkdf2;173;172;185;189;177;162;173;162;210;225 04:04:44 INFO - PID 1649 | |13;stanford-crypto-sha256-iterative;65;67;67;70;69;65;90;66;65;67 04:04:44 INFO - PID 1649 | __end_tp_report 04:04:44 INFO - PID 1649 | __start_cc_report 04:04:44 INFO - PID 1649 | _x_x_mozilla_cycle_collect,2161 04:04:44 INFO - PID 1649 | __end_cc_report 04:04:44 INFO - PID 1649 | __startTimestamp1492686284348__endTimestamp 04:04:44 INFO - PID 1649 | 04:04:44 INFO - PID 1649 | ------- Summary: start ------- 04:04:44 INFO - PID 1649 | Number of tests: 14 04:04:44 INFO - PID 1649 | 04:04:44 INFO - PID 1649 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.50 stddev:0.79 (0.7%) stddev-sans-first:0.83 04:04:44 INFO - PID 1649 | Values: 110.0 109.0 109.0 111.0 110.0 111.0 111.0 111.0 110.0 110.0 04:04:44 INFO - PID 1649 | 04:04:44 INFO - PID 1649 | [#1] audio-beat-detection Cycles:10 Average:127.50 Median:138.00 stddev:18.67 (13.5%) stddev-sans-first:19.06 04:04:44 INFO - PID 1649 | Values: 142.0 108.0 105.0 154.0 140.0 142.0 136.0 104.0 134.0 110.0 04:04:44 INFO - PID 1649 | 04:04:44 INFO - PID 1649 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.50 stddev:2.12 (1.1%) stddev-sans-first:2.19 04:04:44 INFO - PID 1649 | Values: 185.0 183.0 186.0 182.0 181.0 184.0 187.0 182.0 185.0 181.0 04:04:44 INFO - PID 1649 | 04:04:44 INFO - PID 1649 | [#3] audio-fft Cycles:10 Average:72.30 Median:82.00 stddev:14.66 (17.9%) stddev-sans-first:15.28 04:04:44 INFO - PID 1649 | Values: 80.0 58.0 59.0 85.0 49.0 76.0 88.0 86.0 84.0 58.0 04:04:44 INFO - PID 1649 | 04:04:44 INFO - PID 1649 | [#4] audio-oscillator Cycles:10 Average:76.70 Median:77.00 stddev:11.47 (14.9%) stddev-sans-first:10.32 04:04:44 INFO - PID 1649 | Values: 94.0 68.0 85.0 69.0 69.0 66.0 89.0 68.0 68.0 91.0 04:04:44 INFO - PID 1649 | 04:04:44 INFO - PID 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:87.00 stddev:0.82 (0.9%) stddev-sans-first:0.73 04:04:44 INFO - PID 1649 | Values: 85.0 86.0 86.0 86.0 87.0 87.0 87.0 85.0 87.0 87.0 04:04:44 INFO - PID 1649 | 04:04:44 INFO - PID 1649 | [#6] imaging-darkroom Cycles:10 Average:98.90 Median:94.00 stddev:12.89 (13.7%) stddev-sans-first:13.49 04:04:44 INFO - PID 1649 | Values: 93.0 95.0 95.0 95.0 94.0 94.0 94.0 101.0 135.0 93.0 04:04:44 INFO - PID 1649 | 04:04:44 INFO - PID 1649 | [#7] imaging-desaturate Cycles:10 Average:90.20 Median:85.50 stddev:10.33 (12.1%) stddev-sans-first:10.84 04:04:44 INFO - PID 1649 | Values: 86.0 88.0 83.0 85.0 86.0 83.0 90.0 116.0 85.0 100.0 04:04:44 INFO - PID 1649 | 04:04:44 INFO - PID 1649 | [#8] json-parse-financial Cycles:10 Average:47.60 Median:48.00 stddev:1.07 (2.2%) stddev-sans-first:0.71 04:04:44 INFO - PID 1649 | Values: 50.0 47.0 46.0 47.0 47.0 48.0 48.0 48.0 48.0 47.0 04:04:44 INFO - PID 1649 | 04:04:44 INFO - PID 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:68.00 stddev:9.19 (13.5%) stddev-sans-first:8.52 04:04:44 INFO - PID 1649 | Values: 53.0 55.0 59.0 66.0 62.0 61.0 70.0 76.0 77.0 78.0 04:04:44 INFO - PID 1649 | 04:04:44 INFO - PID 1649 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.50 stddev:1.10 (1.3%) stddev-sans-first:1.12 04:04:44 INFO - PID 1649 | Values: 81.0 82.0 83.0 83.0 81.0 82.0 83.0 83.0 81.0 80.0 04:04:44 INFO - PID 1649 | 04:04:44 INFO - PID 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:143.20 Median:140.00 stddev:11.98 (8.6%) stddev-sans-first:12.61 04:04:44 INFO - PID 1649 | Values: 139.0 138.0 137.0 141.0 134.0 139.0 141.0 136.0 174.0 153.0 04:04:44 INFO - PID 1649 | 04:04:44 INFO - PID 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.80 Median:181.00 stddev:20.47 (11.3%) stddev-sans-first:21.40 04:04:44 INFO - PID 1649 | Values: 173.0 172.0 185.0 189.0 177.0 162.0 173.0 162.0 210.0 225.0 04:04:44 INFO - PID 1649 | 04:04:44 INFO - PID 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:67.00 stddev:7.53 (11.2%) stddev-sans-first:7.84 04:04:44 INFO - PID 1649 | Values: 65.0 67.0 67.0 70.0 69.0 65.0 90.0 66.0 65.0 67.0 04:04:44 INFO - PID 1649 | -------- Summary: end -------- 04:04:44 INFO - PID 1649 | 04:04:45 INFO - TEST-INFO | 1649: exit 0 04:04:45 INFO - TEST-OK | kraken | took 59976ms 04:04:45 INFO - SUITE-END | took 1178s 04:04:45 INFO - Completed test suite (00:19:38) 04:04:45 INFO - javascript benchmark 04:04:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7719.753203257066, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3067.6932306769327, 3465.6534346565345, 3468.2890007548453, 3479.1128262293128, 3488.406970814962, 5216.713080780555, 5799.652020878751, 5892.823215303542, 5920.171176035358, 6092.2384701912315, 5882.264716910387, 5907.527397808176, 5920.703964801764, 5923.73343199556, 5936.821895343136, 4592.897704550909, 4834.951650483503, 5203.713795741232, 5224.791008359661, 5246.632735708502, 5278.551323137519, 5283.07546179417, 5290.232916227144, 5291.126964050927, 5297.390800057985, 5270.604704647148, 5283.498067683564, 5286.31277933868, 5291.894162116755, 5292.523672869441, 5279.260903473517, 5282.550983166436, 5292.867678308035, 5293.788248470057, 5294.814681486168, 5129.384473863161, 5229.50319719626, 5233.921491177635, 5248.0553500369915, 5282.762275697564, 6135.110408990671, 6165.10605962133, 6167.5682702210415, 6170.7223174957235, 6190.102435146923, 6279.937200627981, 6347.523935704794, 6353.745850165988, 6369.554131210817, 6374.617522948638, 5080.611823067383, 6360.840978975562, 6373.3945275198785, 6383.808485745435, 6468.967655161741, 6179.5674302798825, 6186.56694031418, 6188.257409110935, 6192.504599632064, 6197.25632924052, 6634.601923884582, 6651.567648102858, 6654.83362915931, 6662.333766623299, 6681.265060843303, 6209.348018458088, 6277.654728989949, 6295.622262664255, 6339.96830015847, 6353.841153971095, 6434.067060276234, 6483.610983341015, 6505.772297969548, 6509.1863517060365, 6513.153290072355, 6360.300366959631, 6388.904166437507, 6428.903566446507, 6432.06735023419, 6432.9678351607945, 6340.968295158495, 6420.876346639319, 6435.259945106279, 6437.130987316652, 6446.161998940202, 5022.723750193774, 5111.8722031948755, 5114.641975061784, 5144.176931690911, 5207.921881171786, 4629.537046295343, 4630.768461576908, 4642.442906851199, 4650.86047418578, 4685.320628508847, 6052.878942421127, 6081.300650425169, 6101.481374083164, 6105.450509454082, 6114.449699527064, 6303.023031430135, 6370.522210834206, 6482.57863238888, 6527.836804079841, 6528.249251336062, 6052.697365131726, 6090.817275481742, 6097.17688112108, 6132.448079672851, 6135.07973803933, 5643.830685079454, 5645.5201307888465, 5658.292713410824, 5658.7170641467765, 5661.0, 6392.169018027626, 6488.091667166695, 6643.7674681385915, 6652.667366631746, 6669.466442684574, 6457.838554036187, 6472.644004579794, 6500.089987401673, 6507.707153178213, 6519.185101862267, 6651.933480665131, 6674.16572928384, 6674.16572928384, 6675.899861501985, 6680.164979377578, 5308.362996440452, 6368.395002474757, 6373.553851230369, 6394.360563943568, 6403.167588213502, 6299.685015749286, 6360.96819515918, 6372.904406433814, 6463.482921366185, 6502.772402966063, 6227.034809604518, 6328.588641738456, 6332.651704156316, 6360.49116070704, 6360.586561873463, 5416.431274716098, 6229.096780966644, 6292.716827742855, 6320.494360451061, 6347.0, 5171.741412929263, 6232.688365581794, 6278.748850045947, 6278.995360742259, 6290.402411770874, 5651.237082993907, 6106.2061931948565, 6247.562670613013, 6300.401461861115, 6314.273858506147, 6090.878182436238, 6231.875362492816, 6265.27949285838, 6266.37336266388, 6277.623342599459], "value": 5877.314789873295, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [758.7344429449694, 798.5328582779074, 813.438727278178, 1122.2480937771697, 1127.560251501915, 26470.0, 27031.594526082125, 36190.27619447613, 36464.81767591165, 36506.817465912696, 38089.0, 38419.807900960455, 38453.80773096137, 38479.80760096203, 38549.03627409316, 8325.167483251687, 8510.319174466027, 8519.062903080687, 8529.10444403338, 8529.147085291483, 6002.96998515009, 6125.877482450348, 7889.684412623516, 8281.089080201173, 8399.37004724645, 7488.764353881603, 8445.071042185355, 8525.701600443987, 8525.914740852606, 8531.402801803844, 8106.959465202695, 8473.067962524117, 8477.576121193915, 8481.067082620906, 8485.151484851527, 8224.671013159466, 8262.504249744974, 8267.917320826775, 8276.420650554464, 8279.710210142677, 36347.81826090879, 36521.269574608355, 36523.81738091292, 36535.26929461396, 36548.81725591382, 3097.984510077435, 3570.9821450892578, 3572.9285414291567, 3573.535440392758, 3574.0528759878653, 30366.93715719939, 30454.695453045406, 30469.69530304691, 30491.390172196432, 30549.694503054907, 3092.860821263026, 3125.890593829228, 3146.7639927005566, 3149.3858697553987, 3162.0671901788796, 206416.0, 283863.0, 284104.0, 284382.0, 290382.0, 47408.5259147411, 47417.0, 47545.81135471641, 47581.762091189325, 47681.523184767706, 50145.498545014816, 50151.0, 50160.498395016315, 50219.0, 50229.74425639388, 13303.068785184943, 13377.33113344329, 13387.799183012263, 13410.262435565943, 13430.597082087554, 10934.015938565568, 10963.177761667906, 10964.122870170368, 10968.670939871816, 10971.067459265892, 9487.762805929908, 10211.846822297672, 10236.0, 10261.692149235534, 11743.416448381342, 5219.973900130475, 5272.551833094153, 5285.207218917117, 5292.20616907467, 5293.391260005072, 996.5266498413196, 1015.4313584392763, 1022.223110436074, 1032.5921261101973, 1067.5356220044305, 24142.275731728078, 24238.757612424004, 29534.55698164529, 29925.40149197004, 30105.849470752506, 1095.4522738630685, 1101.7961677089763, 1135.103268417957, 1136.494260054268, 1141.3095077478172, 10813.891861081289, 12177.208481448677, 12332.568360107352, 12391.93804030974, 12404.8215419535, 303495.0, 303518.0, 303932.0, 303984.0, 304556.4772176169, 45593.77203113963, 45623.77188114038, 45669.54330456653, 45680.543194568294, 46100.3084953726, 1441.7621092519826, 1456.2500312339155, 1499.8725108365693, 1506.698660267929, 1523.8552337527917, 23200.535989279782, 23200.76799231986, 23208.4197895054, 23221.0, 23281.650775238722, 35700.285994280486, 35787.926362209175, 35825.64174358327, 35889.46165807567, 35992.0, 263166.0, 263628.0, 263925.0, 264054.0, 264303.0, 31302.06093817189, 31373.8431307842, 31420.842895785376, 31454.0, 31520.211994700316, 30766.923157689373, 39224.607753923236, 42109.368359475244, 42583.787081064394, 43338.0, 25584.616230756183, 28656.42687146287, 28951.7104828949, 29821.10536683903, 30103.397932041673, 29058.7094129056, 29273.414531709674, 29929.700702993563, 30007.3998520024, 30119.698803011688, 35945.820270898475, 35996.4600530987, 36009.09977250485, 36046.819765901004, 36093.458598120524, 26156.08453704111, 29842.0, 30122.3975520484, 30711.733992855894, 30815.383692326475, 22784.405091643424, 23870.403239919142, 24130.87934560316, 24203.0, 24230.75769242285], "value": 16769.966962054375, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.11996974883573, 427.19021310181535, 434.0580939361586, 441.984530541431, 455.0807369114389, 17146.91426542867, 20707.0, 22235.664650302464, 22479.775202248013, 22702.77297227027, 22368.664470032963, 22435.0, 22696.65955010672, 22753.54492910145, 22771.97526111325, 5891.469767720904, 5952.7916522921705, 6082.482988945922, 6166.7533298667995, 6185.381461853824, 6077.665728384937, 6164.044573091178, 6184.938150618481, 6199.752009919598, 6202.162708034402, 3635.2547727715755, 3665.047087757189, 3777.9622203777885, 6169.506439484853, 6212.81361559154, 6105.32841387447, 6142.600730952474, 6153.0, 6166.8766624667705, 6171.981623032172, 5343.893122137574, 5476.904619076201, 5537.335519737617, 5539.14143307788, 5544.085225937715, 26954.865225673748, 27426.862865685544, 27456.313592160157, 27547.449051018866, 27690.723092769218, 2197.4726065744267, 2246.1801442473543, 2249.5275992041693, 2250.6849041134255, 2251.0770584060456, 17457.301707931667, 18885.0, 19175.90412047945, 19692.803071969385, 19741.40775776729, 2087.634663933821, 2282.2126366403563, 2299.1493147535352, 2312.508432061311, 2406.614941609334, 151060.0, 153728.92542149095, 155735.0, 156258.0, 161407.99999999884, 16757.664846703243, 17810.76623181876, 23135.53728925412, 23218.3379484773, 23379.766202338098, 32071.037868863972, 40593.37901362434, 41005.384919226235, 41231.0, 41321.586784131774, 10572.947135264274, 10692.62575809843, 10774.030337269684, 10783.83824242637, 10935.398553079656, 7552.8867066994035, 8424.199701028392, 8436.662533498591, 8581.313494920516, 8609.82780344402, 10327.431991240554, 11104.279451534265, 11125.72185695348, 11267.591551056117, 11268.887311126948, 4242.406063151161, 4353.4122893408985, 4382.342648602671, 4387.082590077626, 4447.710898791568, 829.78425609342, 951.7382719752123, 970.2722957781664, 982.6806287956442, 998.9550470228712, 18560.628787424175, 19019.953902535493, 20474.078666459747, 20495.0, 21209.0, 970.1317320997808, 971.7862070344513, 979.1579241852002, 998.3311181508407, 1008.1229330482527, 10610.363378197333, 10973.341599503896, 11199.361006414767, 12920.769807548113, 14081.647958801112, 524787.7521224815, 525522.0, 533101.0, 539185.0, 546411.0, 133978.0, 134028.0, 134542.32728836488, 135207.0, 138150.0, 1208.4139192491634, 1215.9635210943686, 1234.062112794265, 1237.4678888078213, 1240.299230934519, 21832.89083554572, 21851.0, 22188.556228875656, 22727.09091636316, 23007.53984920259, 58266.83466330565, 58474.0, 59630.70184649222, 59782.701086494286, 59923.700381499555, 76677.23322766925, 76816.84774728272, 77303.0, 79984.0, 80622.59688701518, 8729.694460693845, 8799.47203167812, 8803.383763136519, 8840.602172902363, 8916.55417229149, 13657.863421365659, 13825.30873456303, 13846.446142154202, 14254.0, 14279.500217492337, 11740.647780566596, 11799.0, 11892.524299028288, 11935.52257909674, 12069.336186509827, 10910.0, 10958.726031849268, 11063.834042489209, 11147.8248753444, 11243.550257989917, 12120.939395302967, 12127.151099422956, 12156.209846359958, 12225.694357640774, 12285.938570307091, 8709.91290087091, 8874.866876996979, 8906.777330566787, 8926.241269492166, 9200.769980750534, 11723.296602203895, 11728.472218750347, 11982.700432489257, 12082.577109801467, 12126.090543209471], "value": 11276.322419500262, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1260.2627462934186, 1417.617243344297, 1438.3743071763777, 1439.3379045639008, 1447.811784468019, 9614.37506562074, 11801.704957376049, 11808.940955295222, 11832.0, 11862.644120676372, 11491.770164596703, 11560.017398521115, 11711.12166587505, 11855.051595872332, 11895.940520297387, 2169.9891500542476, 2512.4095837478226, 2544.580144276192, 2557.207265747615, 2561.2956436979885, 2479.76442237988, 2490.1533478617266, 2553.0, 2554.6678931738847, 2560.7311232320617, 2466.3464181991785, 2563.218218443374, 2563.269468201563, 2567.717551069381, 2570.4345044090364, 2509.573372526675, 2522.268542122782, 2532.3162746058647, 2555.4378036831868, 2562.8846701898274, 2526.8104892133165, 2541.212224210482, 2546.045233037611, 2554.0549996501227, 2557.0666706652123, 11496.885031149748, 11763.529458821637, 11766.470508827124, 11779.646610601696, 11797.941010294979, 5170.767315470813, 6782.864342713118, 6808.6255255960905, 6808.931910680879, 6813.965930170318, 4073.816678249486, 4337.97831010846, 4350.32569951658, 4386.8903277418, 4423.933640995388, 1208.2448469706433, 1228.8095345221504, 1249.7063190150307, 1304.132751720105, 1306.6929271621161, 14925.925370373187, 15207.391704331814, 15584.999999999887, 16539.91730041354, 16548.75176872348, 4690.6012988895645, 4918.975405122951, 5071.340725705709, 6123.663198524124, 6137.478314343241, 13590.59228223155, 13780.173189608455, 13788.965827562974, 13819.930900345635, 13856.792148117785, 6769.492288078315, 6779.898301525481, 6782.694778734969, 6824.624645644438, 6853.897191542131, 6107.7862274821055, 6145.293291271471, 6254.124422580842, 6274.686265686697, 6276.843078923063, 4621.237495813153, 4637.489876113625, 4641.582257596765, 4698.389209402756, 4727.929081063787, 1419.396756378535, 1448.8406275309708, 1451.9128852268898, 1473.8820894328428, 1475.203390169318, 629.7323637454064, 735.400648471494, 770.3452065744185, 780.449782903052, 799.3605115907251, 5980.073088671176, 5997.340292567814, 6228.844278893064, 6258.968705156445, 6322.9051564226575, 576.2940398012485, 577.9277590301213, 596.4125336543501, 604.9848753781102, 611.4069352727847, 3234.5956755405573, 3778.905527361838, 3907.1794923066473, 4233.195692818416, 4344.652427805768, 13934.163950163023, 14252.714945701235, 14906.627334316512, 14918.538441157087, 14951.700965980837, 14120.71758564823, 14267.929905257148, 14575.489857854924, 14593.92703036478, 14601.78097328541, 8127.918720812716, 8378.497290162732, 8408.83182336362, 8421.747347579583, 8448.535330556755, 6525.911708253313, 6548.279689234085, 6806.047153398627, 6819.386255237053, 6924.965375173092, 13141.474341026253, 13185.142965707199, 13389.062765606704, 13489.662758431117, 13501.257430841399, 10616.84074738895, 13008.349582520646, 13639.113457625223, 13736.793948090986, 13862.306884655525, 9310.998135400921, 9560.187384072431, 9570.95214523923, 9572.952135239279, 9579.0, 10443.94778026105, 10554.0, 10566.154707623526, 10631.521581529005, 10640.574377024832, 8847.832281091174, 8988.10118988096, 9075.13786190311, 9146.085391461067, 9194.586243619187, 8725.171108744658, 8858.911410885808, 8919.55402229899, 8927.687530936386, 9134.908650913672, 8047.0745864226365, 8160.918390816016, 8173.713920012771, 8176.01887773471, 8184.140665230065, 5922.3485416605, 5953.523718102455, 6019.097135429721, 6111.449969502766, 6143.293521245114, 5928.170056192051, 6002.129691194665, 6122.173506576555, 6233.2208473940755, 6321.178246828067], "value": 5325.173974190787, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.5775078416878, 402.36828179757777, 404.45600667102747, 404.80771633474086, 413.22314049586794, 5287.074761916663, 5777.42225777422, 5822.592418530699, 5827.4463925927075, 5851.853703657411, 4929.433115191754, 5414.78167412332, 5601.691906945127, 5703.7148142592805, 5767.740451679674, 4359.193549193394, 4364.148990946775, 4373.781310934456, 4374.693771436001, 4378.0, 4346.8702534175345, 4359.280718681413, 4372.0, 4376.868693939187, 4377.824887004516, 3997.6202260785326, 4115.629593336614, 4177.519585247705, 4341.413909122275, 4367.606915377615, 3689.0039689283744, 4006.419069234974, 4164.354525048622, 4171.666266698672, 4190.6018928202075, 3640.908977275563, 3642.1987162824134, 3659.634036596319, 3683.208110256308, 3687.557493100845, 5383.407825139231, 5454.072807622713, 5512.641678290898, 5525.392206857243, 5597.692126933017, 4134.503859536845, 4329.0, 4855.8634200951465, 4900.828471003533, 4926.871436637725, 5958.344582095966, 5973.761049558012, 5984.461398474158, 5997.280326360821, 5998.520118390518, 3472.6527347265323, 3936.7992762207514, 4126.855560055384, 4149.668026557868, 4169.374593810922, 5014.799408023675, 5435.701036442994, 6091.756329746805, 6258.249010118815, 6264.362074133316, 4090.2433049885867, 4199.265128602482, 4205.747655140702, 4209.831606735696, 4211.7262377945335, 3601.423772196436, 4258.14770574801, 4284.721493102938, 4285.207236661227, 4298.76356800379, 4152.667786577066, 4400.779961001937, 4667.409587678871, 4693.225617773098, 4969.633350828551, 4425.2520254499295, 4793.808247670124, 5935.673537955454, 6044.063170208625, 6059.303180134341, 1442.5286208067712, 1456.8615981481742, 1463.8243410790774, 1464.5020692964442, 1465.157534417714, 925.0340927513561, 966.367029595616, 977.8239916815041, 978.0952618827698, 982.7150126463389, 5038.874028149326, 5105.438401775876, 5428.131498960226, 5719.28508936383, 5792.391798861143, 5282.867928301823, 5475.4524547544925, 5894.440028197314, 6241.251049874044, 6266.905996410058, 5440.483154100354, 5512.0, 5635.549156067505, 5673.375928647845, 5732.541396688255, 3265.4855761064323, 3267.068885367659, 3268.8202148881564, 3271.672832716757, 3292.93414131716, 6179.876402471926, 6370.936290637127, 6440.261129495104, 6490.701859628093, 6569.57297775643, 6388.840278993062, 6393.456556192683, 6406.551541392151, 6407.807765767035, 6434.7104380303, 5332.520073193509, 6425.775097871646, 6436.259830119502, 6448.548601597843, 6527.67361631926, 5901.970490147522, 6131.294901086254, 6173.228346456693, 6196.132541444112, 6213.5339849512375, 5171.965606878564, 5192.844214673566, 5230.398504172069, 6103.816885493442, 6155.553444940525, 4806.365835615908, 5292.9735351323, 6263.592866463665, 6407.967960160169, 6424.743010279536, 3539.7876127431405, 3690.3541880170324, 4163.938195760183, 4170.895727606834, 4170.936411215121, 5124.615653826053, 5440.4015558287765, 6047.911375952371, 6180.704410434884, 6253.468455181361, 6066.332703402711, 6083.452489275986, 6125.173101631222, 6146.231721034871, 6154.846128846814, 5299.602529810357, 5384.380796208487, 5621.161313536638, 6096.542759292982, 6155.953487907156, 4814.448342378545, 5646.096624540054, 5651.745671444877, 5985.341612422717, 6030.396960303934, 6063.453819276233, 6065.211522502223, 6102.755889764359, 6103.816885493442, 6120.908186377119, 5272.499112584298, 5541.695206763506, 5662.980663480613, 5813.186153938367, 5933.584649074523], "value": 4401.525770748245, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.3677726823125, 854.8504011797935, 857.5669287010058, 857.7169534053763, 874.8031692869105, 12909.870901290984, 17596.64806703865, 17985.55036124094, 18026.09869506526, 18032.278708851663, 16510.917445412757, 16580.08809515479, 16610.0, 16626.50120496387, 16662.50012499627, 948.1182500274741, 949.4350861237552, 953.6090203016764, 954.0554850697829, 970.257752819094, 943.2312665177892, 945.6831961292975, 950.4059962523423, 950.8383574792302, 995.1740055753743, 1018.1854516386898, 1020.6121673763996, 1022.4734261855151, 1024.0220589337202, 1050.8108540462713, 1011.3426272922659, 1012.5190534496129, 1013.5388398278766, 1015.8222311095528, 1042.8644276244077, 751.2825251884437, 754.1478129713444, 757.7802437293234, 759.8024513626497, 778.4084096086958, 16119.0, 16148.515544533682, 16253.918730406273, 16698.749518757228, 17002.914985424995, 13422.731545369037, 16549.172541373002, 16886.66226675472, 16987.0, 17098.487045388658, 13629.591112266648, 13746.793798093036, 13858.307084645727, 13901.652458688613, 14071.226082565454, 3129.8278594677286, 3148.0, 3152.8108313501034, 3154.7318477929402, 3157.7315928146136, 94120.52939735325, 118341.0, 126533.36733316275, 126714.0, 126788.36605816912, 11048.839871813505, 11348.432578371048, 11379.203455758017, 12900.935495322463, 13016.958643308702, 23872.52254954891, 23903.76096239015, 24131.63802542963, 24504.0, 24926.626100608504, 7547.320741133214, 7619.885701714478, 7632.732854350071, 7706.306432420997, 7710.9590205321565, 3327.8835240766457, 3775.301569209705, 3843.365844635604, 3843.5964223756105, 3856.5757766645647, 4277.850275240352, 4321.178975994551, 4325.264705000158, 4357.2592659248, 4371.0, 812.5774597209418, 930.0745757970863, 950.7005293332578, 951.5765484359393, 952.7665721898179, 589.375262222046, 640.3980258556942, 651.947844172465, 670.6713710282024, 698.9895151572731, 11092.389918554558, 11864.169648032257, 11944.343061131722, 11967.820482692767, 12080.637580872588, 659.120074700271, 663.4891133826926, 665.6671664167916, 675.9560628559128, 695.7078027228577, 5409.377921539073, 5544.91682624761, 5564.081926482085, 5652.97173514138, 5657.2928383952, 101214.0, 102961.45557816638, 103088.0, 104138.95861041444, 106271.46864265784, 88977.0, 89901.0, 91925.0, 92462.53768731114, 92518.53740731253, 79732.08132749642, 80172.59913700394, 80502.33952078414, 80910.5954470224, 82670.0, 9639.325247232626, 10858.728531786768, 11345.319280843176, 11417.885821141683, 11587.942060289644, 39276.0, 39799.80100099481, 40235.0, 40770.38844417277, 41234.587654123075, 51664.0, 52002.73998629983, 52008.47991520036, 52026.47973520216, 52285.43143705695, 14005.73948344654, 14072.366743496772, 14088.436462541384, 14260.0, 14326.713465730418, 15468.303926323568, 15575.610609734847, 15680.686386271982, 15723.371065157724, 15754.684906302038, 14314.141151530941, 14619.049761765451, 14655.92672036633, 14818.555443336718, 16246.918765406097, 16262.105584192983, 16341.836581634032, 16404.0, 16522.42171523991, 16526.256318465938, 16420.178991050638, 16551.08969006716, 16563.751543727096, 16604.58488537796, 16743.24655390486, 11751.882481175078, 11781.352025638673, 12202.450889709808, 12213.572524961939, 12771.74456510846, 12560.12079154487, 13381.330933453093, 13510.527131550349, 13526.053176277566, 13549.729005420033], "value": 8124.008555683182, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1436.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 109.0, 109.0, 111.0, 110.0, 111.0, 111.0, 111.0, 110.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 108.0, 105.0, 154.0, 140.0, 142.0, 136.0, 104.0, 134.0, 110.0], "value": 127.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 186.0, 182.0, 181.0, 184.0, 187.0, 182.0, 185.0, 181.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 59.0, 85.0, 49.0, 76.0, 88.0, 86.0, 84.0, 58.0], "value": 72.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 68.0, 85.0, 69.0, 69.0, 66.0, 89.0, 68.0, 68.0, 91.0], "value": 76.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 86.0, 86.0, 87.0, 87.0, 87.0, 85.0, 87.0, 87.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 101.0, 135.0, 93.0], "value": 98.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 83.0, 85.0, 86.0, 83.0, 90.0, 116.0, 85.0, 100.0], "value": 90.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 47.0, 46.0, 47.0, 47.0, 48.0, 48.0, 48.0, 48.0, 47.0], "value": 47.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 59.0, 66.0, 62.0, 61.0, 70.0, 76.0, 77.0, 78.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 83.0, 83.0, 81.0, 82.0, 83.0, 83.0, 81.0, 80.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 137.0, 141.0, 134.0, 139.0, 141.0, 136.0, 174.0, 153.0], "value": 143.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 185.0, 189.0, 177.0, 162.0, 173.0, 162.0, 210.0, 225.0], "value": 182.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 67.0, 70.0, 69.0, 65.0, 90.0, 66.0, 65.0, 67.0], "value": 69.1, "unit": "score"}]}]} 04:04:45 INFO - Return code: 0 04:04:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:04:45 ERROR - # TBPL SUCCESS # 04:04:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:04:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:04:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:04:45 INFO - 2017-04-20 04:04:45.675 screenresolution[1653:9736] starting screenresolution argv=screenresolution get 04:04:45 INFO - 2017-04-20 04:04:45.679 screenresolution[1653:9736] Display 0: 1600x1200x32@60 04:04:45 INFO - 2017-04-20 04:04:45.685 screenresolution[1654:9739] starting screenresolution argv=screenresolution list 04:04:45 INFO - Available Modes on Display 0 04:04:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:04:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:04:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:04:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:04:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:04:45 INFO - Intel Iris: 04:04:45 INFO - Chipset Model: Intel Iris 04:04:45 INFO - Type: GPU 04:04:45 INFO - Bus: Built-In 04:04:45 INFO - VRAM (Dynamic, Max): 1536 MB 04:04:45 INFO - Vendor: Intel (0x8086) 04:04:45 INFO - Device ID: 0x0a2e 04:04:45 INFO - Revision ID: 0x0009 04:04:45 INFO - Displays: 04:04:45 INFO - Display: 04:04:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:04:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:04:45 INFO - Display Serial Number: 1600x1200 60 04:04:45 INFO - Main Display: Yes 04:04:45 INFO - Mirror: Off 04:04:45 INFO - Online: Yes 04:04:45 INFO - Rotation: Supported 04:04:45 INFO - Return code: 0 04:04:45 INFO - Running post-action listener: _resource_record_post_action 04:04:45 INFO - [mozharness: 2017-04-20 11:04:45.936820Z] Finished run-tests step (success) 04:04:45 INFO - Running post-run listener: _resource_record_post_run 04:04:46 INFO - Total resource usage - Wall time: 1198s; CPU: 53.0%; Read bytes: 36836352; Write bytes: 513554432; Read time: 245; Write time: 1604 04:04:46 INFO - TinderboxPrint: CPU usage
53.3% 04:04:46 INFO - TinderboxPrint: I/O read bytes / time
36,836,352 / 245 04:04:46 INFO - TinderboxPrint: I/O write bytes / time
513,554,432 / 1,604 04:04:46 INFO - TinderboxPrint: CPU idle
2,239.7 (46.7%) 04:04:46 INFO - TinderboxPrint: CPU system
952.8 (19.9%) 04:04:46 INFO - TinderboxPrint: CPU user
1,601.1 (33.4%) 04:04:46 INFO - TinderboxPrint: Swap in / out
244,109,312 / 0 04:04:46 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 194464256; Write bytes: 194373632; Read time: 14856; Write time: 409 04:04:46 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 35865600; Write bytes: 302354432; Read time: 230; Write time: 1145 04:04:46 INFO - Running post-run listener: _upload_blobber_files 04:04:46 INFO - Blob upload gear active. 04:04:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:04:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:04:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:04:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:04:46 INFO - (blobuploader) - INFO - Open directory for files ... 04:04:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:04:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:04:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:47 INFO - (blobuploader) - INFO - Done attempting. 04:04:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:04:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:04:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:49 INFO - (blobuploader) - INFO - Done attempting. 04:04:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:04:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:04:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:50 INFO - (blobuploader) - INFO - Done attempting. 04:04:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:04:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:04:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:52 INFO - (blobuploader) - INFO - Done attempting. 04:04:52 INFO - (blobuploader) - INFO - Iteration through files over. 04:04:52 INFO - Return code: 0 04:04:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:04:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:04:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d25b624a7fe95b125a77c64d75016d28921c150e6c0194d9e6b9cf8c2e76c5b06489deb5b66423b19263da5c852a64aa5da13dc87a8627584f56d1c796307d75", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac1a394e94b598863e39b116540c87544e261011bf39d1d362e6f95449a443edd1518b504333dd298abcbbbaf8f86fa3cf0c45a796cb32a5f2d8810d5c76c727", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62f1642e96673b57dc384a95ecf5b8ff60619e5845ddf04179cb05d8db8689b7249e709d608968ede2d821e035722ff6be2c02bd0c3ae31c25f33924e80f045e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eac107d6a11fd13f3a99574c91fe2745e950a99ab789bd062b61ae724cb89d146a99ab6d357d171249b0ebb238b66d390a9a66fbd6a95709ed2e2a662648bad2"} 04:04:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:04:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:04:52 INFO - Contents: 04:04:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d25b624a7fe95b125a77c64d75016d28921c150e6c0194d9e6b9cf8c2e76c5b06489deb5b66423b19263da5c852a64aa5da13dc87a8627584f56d1c796307d75", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac1a394e94b598863e39b116540c87544e261011bf39d1d362e6f95449a443edd1518b504333dd298abcbbbaf8f86fa3cf0c45a796cb32a5f2d8810d5c76c727", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62f1642e96673b57dc384a95ecf5b8ff60619e5845ddf04179cb05d8db8689b7249e709d608968ede2d821e035722ff6be2c02bd0c3ae31c25f33924e80f045e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eac107d6a11fd13f3a99574c91fe2745e950a99ab789bd062b61ae724cb89d146a99ab6d357d171249b0ebb238b66d390a9a66fbd6a95709ed2e2a662648bad2"} 04:04:52 INFO - Running post-run listener: copy_logs_to_upload_dir 04:04:52 INFO - Copying logs to upload dir... 04:04:52 INFO - mkdir: /builds/slave/test/build/upload/logs 04:04:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.299243 ========= master_lag: 1.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-20 04:04:53.841375) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-20 04:04:53.846935) ========= 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.XDMkKt3QQc/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.TN9sPn0bEf/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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/d25b624a7fe95b125a77c64d75016d28921c150e6c0194d9e6b9cf8c2e76c5b06489deb5b66423b19263da5c852a64aa5da13dc87a8627584f56d1c796307d75", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac1a394e94b598863e39b116540c87544e261011bf39d1d362e6f95449a443edd1518b504333dd298abcbbbaf8f86fa3cf0c45a796cb32a5f2d8810d5c76c727", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62f1642e96673b57dc384a95ecf5b8ff60619e5845ddf04179cb05d8db8689b7249e709d608968ede2d821e035722ff6be2c02bd0c3ae31c25f33924e80f045e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eac107d6a11fd13f3a99574c91fe2745e950a99ab789bd062b61ae724cb89d146a99ab6d357d171249b0ebb238b66d390a9a66fbd6a95709ed2e2a662648bad2"} build_url:https://queue.taskcluster.net/v1/task/TYjExR9nTrahq3TTfwGFEA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010923 build_url: 'https://queue.taskcluster.net/v1/task/TYjExR9nTrahq3TTfwGFEA/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/d25b624a7fe95b125a77c64d75016d28921c150e6c0194d9e6b9cf8c2e76c5b06489deb5b66423b19263da5c852a64aa5da13dc87a8627584f56d1c796307d75", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac1a394e94b598863e39b116540c87544e261011bf39d1d362e6f95449a443edd1518b504333dd298abcbbbaf8f86fa3cf0c45a796cb32a5f2d8810d5c76c727", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62f1642e96673b57dc384a95ecf5b8ff60619e5845ddf04179cb05d8db8689b7249e709d608968ede2d821e035722ff6be2c02bd0c3ae31c25f33924e80f045e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eac107d6a11fd13f3a99574c91fe2745e950a99ab789bd062b61ae724cb89d146a99ab6d357d171249b0ebb238b66d390a9a66fbd6a95709ed2e2a662648bad2"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-20 04:04:53.883360) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 04:04:53.883710) ========= 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.XDMkKt3QQc/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.TN9sPn0bEf/Listeners TMPDIR=/var/folders/05/tvbsjp3n2dgc0q2v0dhyg30c00000w/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.005192 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 04:04:53.935041) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-20 04:04:53.935627) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-20 04:04:53.936306) ========= ========= Total master_lag: 1.18 =========