builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0091 starttime: 1492428588.42 results: success (0) buildid: 20170417030204 builduid: 723bd81f6c9d404ba0582c90ad1a392f revision: c697e756f738ce37abc56f31bfbc48f55625d617 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-17 04:29:48.425423) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-17 04:29:48.425954) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-17 04:29:48.427221) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-17 04:29:48.456009) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 04:29:48.456293) ========= 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.syg3UALygH/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.nbgavzHhSS/Listeners TMPDIR=/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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-17 04:29:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.5M=0.001s 2017-04-17 04:29:49 (14.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.549349 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 04:29:49.027052) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 04:29:49.027350) ========= 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.syg3UALygH/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.nbgavzHhSS/Listeners TMPDIR=/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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.028007 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 04:29:49.076979) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-17 04:29:49.077314) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c697e756f738ce37abc56f31bfbc48f55625d617 --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 c697e756f738ce37abc56f31bfbc48f55625d617 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.syg3UALygH/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.nbgavzHhSS/Listeners TMPDIR=/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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-17 04:29:49,191 truncating revision to first 12 chars 2017-04-17 04:29:49,191 Setting DEBUG logging. 2017-04-17 04:29:49,191 attempt 1/10 2017-04-17 04:29:49,191 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c697e756f738?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-17 04:29:49,896 unpacking tar archive at: mozilla-central-c697e756f738/testing/mozharness/ program finished with exit code 0 elapsedTime=0.990068 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-17 04:29:50.093266) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-17 04:29:50.093881) ========= script_repo_revision: c697e756f738ce37abc56f31bfbc48f55625d617 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-17 04:29:50.094593) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-17 04:29:50.095082) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-17 04:29:50.116838) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2017-04-17 04:29:50.117329) ========= /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.syg3UALygH/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.nbgavzHhSS/Listeners TMPDIR=/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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 04:29:50 INFO - MultiFileLogger online at 20170417 04:29:50 in /builds/slave/test 04:29:50 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 04:29:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:29:50 INFO - {'append_to_log': False, 04:29:50 INFO - 'base_work_dir': '/builds/slave/test', 04:29:50 INFO - 'blob_upload_branch': 'Firefox', 04:29:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:29:50 INFO - 'branch': 'Firefox', 04:29:50 INFO - 'buildbot_json_path': 'buildprops.json', 04:29:50 INFO - 'config_files': ('talos/mac_config.py',), 04:29:50 INFO - 'default_actions': ('clobber', 04:29:50 INFO - 'read-buildbot-config', 04:29:50 INFO - 'download-and-extract', 04:29:50 INFO - 'populate-webroot', 04:29:50 INFO - 'create-virtualenv', 04:29:50 INFO - 'install', 04:29:50 INFO - 'run-tests'), 04:29:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:29:50 INFO - 'download_minidump_stackwalk': True, 04:29:50 INFO - 'download_symbols': 'ondemand', 04:29:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:29:50 INFO - 'tooltool.py': '/tools/tooltool.py', 04:29:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:29:50 INFO - '/tools/misc-python/virtualenv.py')}, 04:29:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:29:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:29:50 INFO - 'gecko_profile': False, 04:29:50 INFO - 'gecko_profile_interval': 0, 04:29:50 INFO - 'installer_path': 'installer.exe', 04:29:50 INFO - 'log_level': 'info', 04:29:50 INFO - 'log_name': 'talos', 04:29:50 INFO - 'log_to_console': True, 04:29:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:29:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:29:50 INFO - 'opt_config_files': (), 04:29:50 INFO - 'pip_index': False, 04:29:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:29:50 INFO - 'cmd': ('bash', 04:29:50 INFO - '-c', 04:29:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:29:50 INFO - 'enabled': True, 04:29:50 INFO - 'halt_on_failure': False, 04:29:50 INFO - 'name': 'check_screen_resolution'},), 04:29:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:29:50 INFO - 'cmd': ('bash', 04:29:50 INFO - '-c', 04:29:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:29:50 INFO - 'enabled': True, 04:29:50 INFO - 'halt_on_failure': False, 04:29:50 INFO - 'name': 'check_screen_resolution'},), 04:29:50 INFO - 'run_cmd_checks_enabled': True, 04:29:50 INFO - 'suite': 'dromaeojs', 04:29:50 INFO - 'system_bits': '32', 04:29:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:29:50 INFO - 'title': 't-yosemite-r7-0091', 04:29:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:29:50 INFO - 'use_talos_json': True, 04:29:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:29:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:29:50 INFO - 'work_dir': 'build'} 04:29:50 INFO - [mozharness: 2017-04-17 11:29:50.334084Z] Running clobber step. 04:29:50 INFO - Running pre-action listener: _resource_record_pre_action 04:29:50 INFO - Running main action method: clobber 04:29:50 INFO - rmtree: /builds/slave/test/build 04:29:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:29:52 INFO - Running post-action listener: _resource_record_post_action 04:29:52 INFO - [mozharness: 2017-04-17 11:29:52.893832Z] Finished clobber step (success) 04:29:52 INFO - [mozharness: 2017-04-17 11:29:52.894011Z] Running read-buildbot-config step. 04:29:52 INFO - Running pre-action listener: _resource_record_pre_action 04:29:52 INFO - Running main action method: read_buildbot_config 04:29:52 INFO - Using buildbot properties: 04:29:52 INFO - { 04:29:52 INFO - "project": "", 04:29:52 INFO - "product": "firefox", 04:29:52 INFO - "script_repo_revision": "production", 04:29:52 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:29:52 INFO - "repository": "", 04:29:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:29:52 INFO - "buildid": "20170417030204", 04:29:52 INFO - "stage_platform": "macosx64", 04:29:52 INFO - "basedir": "/builds/slave/test", 04:29:52 INFO - "nightly_build": "True", 04:29:52 INFO - "buildnumber": 80, 04:29:52 INFO - "slavename": "t-yosemite-r7-0091", 04:29:52 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 04:29:52 INFO - "platform": "yosemite_r7", 04:29:52 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:29:52 INFO - "branch": "mozilla-central", 04:29:52 INFO - "repo_path": "mozilla-central", 04:29:52 INFO - "revision": "c697e756f738ce37abc56f31bfbc48f55625d617", 04:29:52 INFO - "pgo_build": "False", 04:29:52 INFO - "builduid": "723bd81f6c9d404ba0582c90ad1a392f", 04:29:52 INFO - "slavebuilddir": "test" 04:29:52 INFO - } 04:29:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/Nf1hrFrlQW6SHW1SOPBElQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:29:52 INFO - Running post-action listener: _resource_record_post_action 04:29:52 INFO - [mozharness: 2017-04-17 11:29:52.897412Z] Finished read-buildbot-config step (success) 04:29:52 INFO - [mozharness: 2017-04-17 11:29:52.897528Z] Running download-and-extract step. 04:29:52 INFO - Running pre-action listener: _resource_record_pre_action 04:29:52 INFO - Running main action method: download_and_extract 04:29:52 INFO - mkdir: /builds/slave/test/build/tests 04:29:52 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')]} 04:29:52 INFO - trying https://queue.taskcluster.net/v1/task/Nf1hrFrlQW6SHW1SOPBElQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:29:52 INFO - Downloading https://queue.taskcluster.net/v1/task/Nf1hrFrlQW6SHW1SOPBElQ/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 04:29:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nf1hrFrlQW6SHW1SOPBElQ/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 04:29:54 INFO - Downloaded 1325 bytes. 04:29:54 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:29:54 INFO - Using the following test package requirements: 04:29:54 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:29:54 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:29:54 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:29:54 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:29:54 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:29:54 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:29:54 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:29:54 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:29:54 INFO - u'jsshell-mac.zip'], 04:29:54 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:29:54 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:29:54 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:29:54 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:29:54 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:29:54 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:29:54 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:29:54 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:29:54 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:29:54 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:29:54 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:29:54 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:29:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nf1hrFrlQW6SHW1SOPBElQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:29:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nf1hrFrlQW6SHW1SOPBElQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:29:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Nf1hrFrlQW6SHW1SOPBElQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:29:55 INFO - Expected file size: 52658499 04:29:55 INFO - Obtained file size: 52658499 04:30:11 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 04:30:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nf1hrFrlQW6SHW1SOPBElQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:30:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nf1hrFrlQW6SHW1SOPBElQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:30:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Nf1hrFrlQW6SHW1SOPBElQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:30:13 INFO - Expected file size: 52658499 04:30:13 INFO - Obtained file size: 52658499 04:30:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nf1hrFrlQW6SHW1SOPBElQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:30:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nf1hrFrlQW6SHW1SOPBElQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:30:29 INFO - Fetch https://queue.taskcluster.net/v1/task/Nf1hrFrlQW6SHW1SOPBElQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:30:30 INFO - Expected file size: 14408802 04:30:30 INFO - Obtained file size: 14408802 04:30: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')]} 04:30:31 INFO - trying https://queue.taskcluster.net/v1/task/Nf1hrFrlQW6SHW1SOPBElQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:30:31 INFO - Downloading https://queue.taskcluster.net/v1/task/Nf1hrFrlQW6SHW1SOPBElQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:30:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nf1hrFrlQW6SHW1SOPBElQ/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 04:30:33 INFO - Downloaded 71520861 bytes. 04:30:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nf1hrFrlQW6SHW1SOPBElQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:30:33 INFO - mkdir: /builds/slave/test/properties 04:30:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:30:33 INFO - Writing to file /builds/slave/test/properties/build_url 04:30:33 INFO - Contents: 04:30:33 INFO - build_url:https://queue.taskcluster.net/v1/task/Nf1hrFrlQW6SHW1SOPBElQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:30:33 INFO - Running post-action listener: _resource_record_post_action 04:30:33 INFO - Running post-action listener: set_extra_try_arguments 04:30:33 INFO - [mozharness: 2017-04-17 11:30:33.814751Z] Finished download-and-extract step (success) 04:30:33 INFO - [mozharness: 2017-04-17 11:30:33.814896Z] Running populate-webroot step. 04:30:33 INFO - Running pre-action listener: _resource_record_pre_action 04:30:33 INFO - Running main action method: populate_webroot 04:30:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:30:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:30:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:30:33 INFO - '--tppagecycles', 04:30:33 INFO - '7'], 04:30:33 INFO - 'tests': ['tsvgm']}}, 04:30:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:30:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:30:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:30:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:30:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:30:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:30:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:30:33 INFO - 'talos_options': ['--disable-e10s'], 04:30:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:30:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:30:33 INFO - 'talos_options': ['--disable-e10s'], 04:30:33 INFO - 'tests': ['damp', 'tps']}, 04:30:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:30:33 INFO - 'tests': ['damp', 'tps']}, 04:30:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:30:33 INFO - 'tests': ['dromaeo_dom']}, 04:30:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:30:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:30:33 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:30:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:30:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:30:33 INFO - 'tests': ['a11yr', 04:30:33 INFO - 'ts_paint', 04:30:33 INFO - 'tpaint', 04:30:33 INFO - 'sessionrestore', 04:30:33 INFO - 'sessionrestore_no_auto_restore', 04:30:33 INFO - 'tabpaint']}, 04:30:33 INFO - 'other-e10s': {'tests': ['a11yr', 04:30:33 INFO - 'ts_paint', 04:30:33 INFO - 'tpaint', 04:30:33 INFO - 'sessionrestore', 04:30:33 INFO - 'sessionrestore_no_auto_restore', 04:30:33 INFO - 'tabpaint']}, 04:30:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:30:33 INFO - 'ts_paint', 04:30:33 INFO - 'tpaint', 04:30:33 INFO - 'sessionrestore', 04:30:33 INFO - 'sessionrestore_no_auto_restore', 04:30:33 INFO - 'tabpaint']}, 04:30:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:30:33 INFO - 'ts_paint', 04:30:33 INFO - 'tpaint', 04:30:33 INFO - 'sessionrestore', 04:30:33 INFO - 'sessionrestore_no_auto_restore', 04:30:33 INFO - 'tabpaint']}, 04:30:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:30:33 INFO - 'tests': ['a11yr', 04:30:33 INFO - 'ts_paint', 04:30:33 INFO - 'tpaint', 04:30:33 INFO - 'sessionrestore', 04:30:33 INFO - 'sessionrestore_no_auto_restore', 04:30:33 INFO - 'tabpaint']}, 04:30:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:30:33 INFO - 'tests': ['a11yr', 04:30:33 INFO - 'ts_paint', 04:30:33 INFO - 'tpaint', 04:30:33 INFO - 'sessionrestore', 04:30:33 INFO - 'sessionrestore_no_auto_restore', 04:30:33 INFO - 'tabpaint']}, 04:30:33 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:30:33 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:30:33 INFO - 'bloom_basic_ref']}, 04:30:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:30:33 INFO - 'tests': ['tsvgx', 04:30:33 INFO - 'tsvgr_opacity', 04:30:33 INFO - 'tart', 04:30:33 INFO - 'tscrollx', 04:30:33 INFO - 'cart', 04:30:33 INFO - 'tsvg_static']}, 04:30:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:30:33 INFO - 'tsvgr_opacity', 04:30:33 INFO - 'tart', 04:30:33 INFO - 'tscrollx', 04:30:33 INFO - 'cart', 04:30:33 INFO - 'tsvg_static']}, 04:30:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:30:33 INFO - 'talos_options': ['--disable-e10s'], 04:30:33 INFO - 'tests': ['tp5o']}, 04:30:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:30:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:30:33 INFO - 'talos_options': ['--disable-e10s', 04:30:33 INFO - '--xperf_path', 04:30:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:33 INFO - 'tests': ['tp5n']}, 04:30:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:30:33 INFO - 'talos_options': ['--xperf_path', 04:30:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:33 INFO - 'tests': ['tp5n']}}, 04:30:33 INFO - 'talos.zip': {'path': '', 04:30:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:30:33 INFO - Running post-action listener: _resource_record_post_action 04:30:33 INFO - [mozharness: 2017-04-17 11:30:33.833835Z] Finished populate-webroot step (success) 04:30:33 INFO - [mozharness: 2017-04-17 11:30:33.833977Z] Running create-virtualenv step. 04:30:33 INFO - Running pre-action listener: _resource_record_pre_action 04:30:33 INFO - Running main action method: create_virtualenv 04:30:33 INFO - Creating virtualenv /builds/slave/test/build/venv 04:30:33 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 04:30:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:30:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:30:33 INFO - Using real prefix '/tools/python27' 04:30:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:30:34 INFO - Installing distribute.............................................................................................................................................................................................done. 04:30:37 INFO - Installing pip.................done. 04:30:37 INFO - Return code: 0 04:30:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:30:37 INFO - Reading from file tmpfile_stdout 04:30:37 INFO - Output received: 04:30:37 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) 04:30:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:30:37 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')]} 04:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:37 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')]} 04:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:37 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 0x10e1b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd74bdbaa70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df93d30>, '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 0x10deb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df88be8>, '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.syg3UALygH/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.nbgavzHhSS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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 04:30:37 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 04:30:37 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 04:30:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.syg3UALygH/Render', 04:30:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:37 INFO - 'HOME': '/Users/cltbld', 04:30:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:37 INFO - 'LOGNAME': 'cltbld', 04:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:37 INFO - 'MOZ_NO_REMOTE': '1', 04:30:37 INFO - 'NO_EM_RESTART': '1', 04:30:37 INFO - 'PAGER': '/bin/cat', 04:30:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:37 INFO - 'PWD': '/builds/slave/test', 04:30:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:37 INFO - 'SHELL': '/bin/bash', 04:30:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nbgavzHhSS/Listeners', 04:30:37 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 04:30:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:37 INFO - 'USER': 'cltbld', 04:30:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:37 INFO - 'XPC_FLAGS': '0x0', 04:30:37 INFO - 'XPC_SERVICE_NAME': '0', 04:30:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:38 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 04:30:38 INFO - Cleaning up... 04:30:38 INFO - Return code: 0 04:30:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e1b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd74bdbaa70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df93d30>, '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 0x10deb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df88be8>, '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.syg3UALygH/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.nbgavzHhSS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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 04:30:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:30:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:30:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.syg3UALygH/Render', 04:30:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:38 INFO - 'HOME': '/Users/cltbld', 04:30:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:38 INFO - 'LOGNAME': 'cltbld', 04:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:38 INFO - 'MOZ_NO_REMOTE': '1', 04:30:38 INFO - 'NO_EM_RESTART': '1', 04:30:38 INFO - 'PAGER': '/bin/cat', 04:30:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:38 INFO - 'PWD': '/builds/slave/test', 04:30:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:38 INFO - 'SHELL': '/bin/bash', 04:30:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nbgavzHhSS/Listeners', 04:30:38 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 04:30:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:38 INFO - 'USER': 'cltbld', 04:30:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:38 INFO - 'XPC_FLAGS': '0x0', 04:30:38 INFO - 'XPC_SERVICE_NAME': '0', 04:30:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:38 INFO - Downloading/unpacking psutil>=3.1.1 04:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:30:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:42 INFO - Installing collected packages: psutil 04:30:42 INFO - Running setup.py install for psutil 04:30:42 INFO - building 'psutil._psutil_osx' extension 04:30:42 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 04:30:43 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 04:30:43 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 04:30:43 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 04:30:43 INFO - building 'psutil._psutil_posix' extension 04:30:43 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 04:30:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:30:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:30:43 INFO - ^ 04:30:43 INFO - 1 warning generated. 04:30:43 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 04:30:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:43 INFO - Successfully installed psutil 04:30:43 INFO - Cleaning up... 04:30:43 INFO - Return code: 0 04:30:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:30:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd74bdbaa70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df93d30>, '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 0x10deb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df88be8>, '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.syg3UALygH/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.nbgavzHhSS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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 04:30:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:30:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:30:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.syg3UALygH/Render', 04:30:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:43 INFO - 'HOME': '/Users/cltbld', 04:30:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:43 INFO - 'LOGNAME': 'cltbld', 04:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:43 INFO - 'MOZ_NO_REMOTE': '1', 04:30:43 INFO - 'NO_EM_RESTART': '1', 04:30:43 INFO - 'PAGER': '/bin/cat', 04:30:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:43 INFO - 'PWD': '/builds/slave/test', 04:30:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:43 INFO - 'SHELL': '/bin/bash', 04:30:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nbgavzHhSS/Listeners', 04:30:43 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 04:30:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:43 INFO - 'USER': 'cltbld', 04:30:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:43 INFO - 'XPC_FLAGS': '0x0', 04:30:43 INFO - 'XPC_SERVICE_NAME': '0', 04:30:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:30:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:30:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:30:46 INFO - Installing collected packages: mozsystemmonitor 04:30:46 INFO - Running setup.py install for mozsystemmonitor 04:30:46 INFO - Successfully installed mozsystemmonitor 04:30:46 INFO - Cleaning up... 04:30:46 INFO - Return code: 0 04:30:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:30: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')]} 04:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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')]} 04:30:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd74bdbaa70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df93d30>, '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 0x10deb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df88be8>, '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.syg3UALygH/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.nbgavzHhSS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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 04:30: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==2.5.1'] in /builds/slave/test/build 04:30: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==2.5.1 04:30:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.syg3UALygH/Render', 04:30:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:46 INFO - 'HOME': '/Users/cltbld', 04:30:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:46 INFO - 'LOGNAME': 'cltbld', 04:30:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:46 INFO - 'MOZ_NO_REMOTE': '1', 04:30:46 INFO - 'NO_EM_RESTART': '1', 04:30:46 INFO - 'PAGER': '/bin/cat', 04:30:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:46 INFO - 'PWD': '/builds/slave/test', 04:30:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:46 INFO - 'SHELL': '/bin/bash', 04:30:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nbgavzHhSS/Listeners', 04:30:46 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 04:30:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:46 INFO - 'USER': 'cltbld', 04:30:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:46 INFO - 'XPC_FLAGS': '0x0', 04:30:46 INFO - 'XPC_SERVICE_NAME': '0', 04:30:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:47 INFO - Downloading/unpacking jsonschema==2.5.1 04:30:47 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 04:30:47 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 04:30:47 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 04:30:47 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 04:30:47 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 04:30:47 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 04:30:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:30:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:30:49 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 04:30:49 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 04:30:49 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 04:30:49 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 04:30:49 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 04:30:49 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 04:30:50 INFO - Downloading functools32-3.2.3-2.tar.gz 04:30:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:30:50 INFO - warning: no files found matching '*.txt' 04:30:50 INFO - no previously-included directories found matching 'build' 04:30:50 INFO - no previously-included directories found matching 'dist' 04:30:50 INFO - no previously-included directories found matching '.git*' 04:30:50 INFO - Installing collected packages: jsonschema, functools32 04:30:50 INFO - Running setup.py install for functools32 04:30:50 INFO - warning: no files found matching '*.txt' 04:30:50 INFO - no previously-included directories found matching 'build' 04:30:50 INFO - no previously-included directories found matching 'dist' 04:30:50 INFO - no previously-included directories found matching '.git*' 04:30:50 INFO - Successfully installed jsonschema functools32 04:30:50 INFO - Cleaning up... 04:30:50 INFO - Return code: 0 04:30:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:50 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 0x10e1b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd74bdbaa70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df93d30>, '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 0x10deb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df88be8>, '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.syg3UALygH/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.nbgavzHhSS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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 04:30:50 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 04:30:50 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 04:30:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.syg3UALygH/Render', 04:30:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:50 INFO - 'HOME': '/Users/cltbld', 04:30:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:50 INFO - 'LOGNAME': 'cltbld', 04:30:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:50 INFO - 'MOZ_NO_REMOTE': '1', 04:30:50 INFO - 'NO_EM_RESTART': '1', 04:30:50 INFO - 'PAGER': '/bin/cat', 04:30:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:50 INFO - 'PWD': '/builds/slave/test', 04:30:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:50 INFO - 'SHELL': '/bin/bash', 04:30:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nbgavzHhSS/Listeners', 04:30:50 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 04:30:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:50 INFO - 'USER': 'cltbld', 04:30:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:50 INFO - 'XPC_FLAGS': '0x0', 04:30:50 INFO - 'XPC_SERVICE_NAME': '0', 04:30:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:30:50 INFO - Cleaning up... 04:30:50 INFO - Return code: 0 04:30:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:50 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 0x10e1b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd74bdbaa70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df93d30>, '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 0x10deb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df88be8>, '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.syg3UALygH/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.nbgavzHhSS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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 04:30:50 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 04:30:50 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 04:30:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.syg3UALygH/Render', 04:30:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:50 INFO - 'HOME': '/Users/cltbld', 04:30:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:50 INFO - 'LOGNAME': 'cltbld', 04:30:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:50 INFO - 'MOZ_NO_REMOTE': '1', 04:30:50 INFO - 'NO_EM_RESTART': '1', 04:30:50 INFO - 'PAGER': '/bin/cat', 04:30:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:50 INFO - 'PWD': '/builds/slave/test', 04:30:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:50 INFO - 'SHELL': '/bin/bash', 04:30:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nbgavzHhSS/Listeners', 04:30:50 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 04:30:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:50 INFO - 'USER': 'cltbld', 04:30:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:50 INFO - 'XPC_FLAGS': '0x0', 04:30:50 INFO - 'XPC_SERVICE_NAME': '0', 04:30:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:51 INFO - Downloading/unpacking blobuploader==1.2.4 04:30:51 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 04:30:51 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 04:30:51 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 04:30:51 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 04:30:51 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 04:30:51 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 04:30:53 INFO - Downloading blobuploader-1.2.4.tar.gz 04:30:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:30:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:30:53 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 04:30:53 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 04:30:53 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 04:30:53 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 04:30:53 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 04:30:53 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 04:30:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:30:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:54 INFO - Downloading docopt-0.6.1.tar.gz 04:30:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:30:55 INFO - Installing collected packages: blobuploader, requests, docopt 04:30:55 INFO - Running setup.py install for blobuploader 04:30:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:30:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:30:55 INFO - Running setup.py install for requests 04:30:55 INFO - Running setup.py install for docopt 04:30:55 INFO - Successfully installed blobuploader requests docopt 04:30:55 INFO - Cleaning up... 04:30:56 INFO - Return code: 0 04:30:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30:56 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')]} 04:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:56 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')]} 04:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:56 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 0x10e1b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd74bdbaa70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df93d30>, '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 0x10deb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df88be8>, '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.syg3UALygH/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.nbgavzHhSS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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 04:30:56 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 04:30:56 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 04:30:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.syg3UALygH/Render', 04:30:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:56 INFO - 'HOME': '/Users/cltbld', 04:30:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:56 INFO - 'LOGNAME': 'cltbld', 04:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:56 INFO - 'MOZ_NO_REMOTE': '1', 04:30:56 INFO - 'NO_EM_RESTART': '1', 04:30:56 INFO - 'PAGER': '/bin/cat', 04:30:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:56 INFO - 'PWD': '/builds/slave/test', 04:30:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:56 INFO - 'SHELL': '/bin/bash', 04:30:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nbgavzHhSS/Listeners', 04:30:56 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 04:30:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:56 INFO - 'USER': 'cltbld', 04:30:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:56 INFO - 'XPC_FLAGS': '0x0', 04:30:56 INFO - 'XPC_SERVICE_NAME': '0', 04:30:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:30:56 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-DhkxQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:30:56 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-FmgCFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:30:56 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-qeU4hp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:30:56 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-0YMdM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:30:56 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-Kckt6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:30:56 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-e5zHNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:30:56 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-UqYQkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:30:56 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-DhXSyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:30:57 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-X1zLnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:30:57 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-Pch7rc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:30:57 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-2iT0CO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:30:57 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-cOXe9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:30:57 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-y1Cbuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:30:57 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-Rp6LyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:57 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-wOCcYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:30:57 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-zoY1jH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:30:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:30:57 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-eg87fK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:30:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:30:58 INFO - Running setup.py install for manifestparser 04:30:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:30:58 INFO - Running setup.py install for mozcrash 04:30:58 INFO - Running setup.py install for mozdebug 04:30:58 INFO - Running setup.py install for mozdevice 04:30:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:30:58 INFO - Running setup.py install for mozfile 04:30:58 INFO - Running setup.py install for mozhttpd 04:30:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:30:58 INFO - Running setup.py install for mozinfo 04:30:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:30:59 INFO - Running setup.py install for mozInstall 04:30:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:30:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:30:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:30:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:30:59 INFO - Running setup.py install for mozleak 04:30:59 INFO - Running setup.py install for mozlog 04:30:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:30:59 INFO - Running setup.py install for moznetwork 04:30:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:30:59 INFO - Running setup.py install for mozprocess 04:30:59 INFO - Running setup.py install for mozprofile 04:30:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:30:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:30:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:31:00 INFO - Running setup.py install for mozrunner 04:31:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:31:00 INFO - Running setup.py install for mozscreenshot 04:31:00 INFO - Running setup.py install for moztest 04:31:00 INFO - Running setup.py install for mozversion 04:31:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:31:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:31:00 INFO - Cleaning up... 04:31:00 INFO - Return code: 0 04:31:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:00 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 0x10e1b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd74bdbaa70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df93d30>, '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 0x10deb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df88be8>, '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.syg3UALygH/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.nbgavzHhSS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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 04:31:00 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 04:31:00 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 04:31:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.syg3UALygH/Render', 04:31:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:00 INFO - 'HOME': '/Users/cltbld', 04:31:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:00 INFO - 'LOGNAME': 'cltbld', 04:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:00 INFO - 'MOZ_NO_REMOTE': '1', 04:31:00 INFO - 'NO_EM_RESTART': '1', 04:31:00 INFO - 'PAGER': '/bin/cat', 04:31:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:00 INFO - 'PWD': '/builds/slave/test', 04:31:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:00 INFO - 'SHELL': '/bin/bash', 04:31:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nbgavzHhSS/Listeners', 04:31:00 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 04:31:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:00 INFO - 'USER': 'cltbld', 04:31:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:00 INFO - 'XPC_FLAGS': '0x0', 04:31:00 INFO - 'XPC_SERVICE_NAME': '0', 04:31:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:00 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-lIypWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:01 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)) 04:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:01 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-hFs57u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:01 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)) 04:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:01 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-udlgVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:01 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)) 04:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:01 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-0gLOCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:01 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)) 04:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:01 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-FOAK96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:01 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)) 04:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:01 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-J5Kgan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:01 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)) 04:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:01 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-kzNoMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:01 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)) 04:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:01 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-hirmZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:01 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)) 04:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:01 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-wTNvKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:01 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)) 04:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:01 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-6O9kmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:01 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)) 04:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:01 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-4kqUWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:02 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)) 04:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:02 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-lKDYlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:02 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)) 04:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:02 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-JDgm2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:02 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)) 04:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:02 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-NmnI9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:02 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)) 04:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:02 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-1nUqfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:02 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)) 04:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:02 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-n2ylpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:02 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)) 04:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:02 INFO - Running setup.py (path:/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/pip-LatoHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:02 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)) 04:31:02 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)) 04:31:02 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)) 04:31:02 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)) 04:31:02 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)) 04:31:02 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)) 04:31:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:05 INFO - Downloading blessings-1.6.tar.gz 04:31:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:31:05 INFO - Installing collected packages: blessings 04:31:05 INFO - Running setup.py install for blessings 04:31:05 INFO - Successfully installed blessings 04:31:05 INFO - Cleaning up... 04:31:05 INFO - Return code: 0 04:31:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:31:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:05 INFO - Reading from file tmpfile_stdout 04:31:05 INFO - Current package versions: 04:31:05 INFO - blessings == 1.6 04:31:05 INFO - blobuploader == 1.2.4 04:31:05 INFO - docopt == 0.6.1 04:31:05 INFO - functools32 == 3.2.3-2 04:31:05 INFO - jsonschema == 2.5.1 04:31:05 INFO - manifestparser == 1.1 04:31:05 INFO - mozInstall == 1.12 04:31:05 INFO - mozcrash == 1.0 04:31:05 INFO - mozdebug == 0.1 04:31:05 INFO - mozdevice == 0.50 04:31:05 INFO - mozfile == 1.2 04:31:05 INFO - mozhttpd == 0.7 04:31:05 INFO - mozinfo == 0.9 04:31:05 INFO - mozleak == 0.1 04:31:05 INFO - mozlog == 3.4 04:31:05 INFO - moznetwork == 0.27 04:31:05 INFO - mozprocess == 0.25 04:31:05 INFO - mozprofile == 0.28 04:31:05 INFO - mozrunner == 6.13 04:31:05 INFO - mozscreenshot == 0.1 04:31:05 INFO - mozsystemmonitor == 0.3 04:31:05 INFO - moztest == 0.8 04:31:05 INFO - mozversion == 1.4 04:31:05 INFO - psutil == 3.1.1 04:31:05 INFO - requests == 1.2.3 04:31:05 INFO - wsgiref == 0.1.2 04:31:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:05 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')]} 04:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:05 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')]} 04:31:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:06 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 0x10e1b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd74bdbaa70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df93d30>, '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 0x10deb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df88be8>, '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.syg3UALygH/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.nbgavzHhSS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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 04:31:06 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 04:31:06 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 04:31:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.syg3UALygH/Render', 04:31:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:06 INFO - 'HOME': '/Users/cltbld', 04:31:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:06 INFO - 'LOGNAME': 'cltbld', 04:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:06 INFO - 'MOZ_NO_REMOTE': '1', 04:31:06 INFO - 'NO_EM_RESTART': '1', 04:31:06 INFO - 'PAGER': '/bin/cat', 04:31:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:06 INFO - 'PWD': '/builds/slave/test', 04:31:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:06 INFO - 'SHELL': '/bin/bash', 04:31:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nbgavzHhSS/Listeners', 04:31:06 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 04:31:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:06 INFO - 'USER': 'cltbld', 04:31:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:06 INFO - 'XPC_FLAGS': '0x0', 04:31:06 INFO - 'XPC_SERVICE_NAME': '0', 04:31:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:06 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)) 04:31:06 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)) 04:31:06 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)) 04:31:06 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)) 04:31:06 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)) 04:31:06 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)) 04:31:06 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)) 04:31:06 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)) 04:31:06 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)) 04:31:06 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)) 04:31:06 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)) 04:31:06 INFO - Cleaning up... 04:31:06 INFO - Return code: 0 04:31:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:06 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 0x10e1b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd74bdbaa70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df93d30>, '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 0x10deb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df88be8>, '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.syg3UALygH/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.nbgavzHhSS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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 04:31:06 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 04:31:06 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 04:31:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.syg3UALygH/Render', 04:31:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:06 INFO - 'HOME': '/Users/cltbld', 04:31:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:06 INFO - 'LOGNAME': 'cltbld', 04:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:06 INFO - 'MOZ_NO_REMOTE': '1', 04:31:06 INFO - 'NO_EM_RESTART': '1', 04:31:06 INFO - 'PAGER': '/bin/cat', 04:31:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:06 INFO - 'PWD': '/builds/slave/test', 04:31:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:06 INFO - 'SHELL': '/bin/bash', 04:31:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nbgavzHhSS/Listeners', 04:31:06 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 04:31:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:06 INFO - 'USER': 'cltbld', 04:31:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:06 INFO - 'XPC_FLAGS': '0x0', 04:31:06 INFO - 'XPC_SERVICE_NAME': '0', 04:31:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:31:06 INFO - Cleaning up... 04:31:06 INFO - Return code: 0 04:31:06 INFO - Running post-action listener: _resource_record_post_action 04:31:06 INFO - Running post-action listener: _start_resource_monitoring 04:31:06 INFO - Starting resource monitoring. 04:31:06 INFO - [mozharness: 2017-04-17 11:31:06.562325Z] Finished create-virtualenv step (success) 04:31:06 INFO - [mozharness: 2017-04-17 11:31:06.563286Z] Running install step. 04:31:06 INFO - Running pre-action listener: _resource_record_pre_action 04:31:06 INFO - Running main action method: install 04:31:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:06 INFO - Reading from file tmpfile_stdout 04:31:06 INFO - Detecting whether we're running mozinstall >=1.0... 04:31:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:31:06 INFO - Reading from file tmpfile_stdout 04:31:06 INFO - Output received: 04:31:06 INFO - Usage: mozinstall [options] installer 04:31:06 INFO - Options: 04:31:06 INFO - -h, --help show this help message and exit 04:31:06 INFO - -d DEST, --destination=DEST 04:31:06 INFO - Directory to install application into. [default: 04:31:06 INFO - "/builds/slave/test"] 04:31:06 INFO - --app=APP Application being installed. [default: firefox] 04:31:06 INFO - mkdir: /builds/slave/test/build/application 04:31:06 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'] 04:31:06 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 04:31:26 INFO - Reading from file tmpfile_stdout 04:31:26 INFO - Output received: 04:31:26 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:31:26 INFO - Running post-action listener: _resource_record_post_action 04:31:26 INFO - [mozharness: 2017-04-17 11:31:26.728547Z] Finished install step (success) 04:31:26 INFO - [mozharness: 2017-04-17 11:31:26.728685Z] Running run-tests step. 04:31:26 INFO - Running pre-action listener: _resource_record_pre_action 04:31:26 INFO - Running main action method: run_tests 04:31:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:31:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:31:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:31:26 INFO - 2017-04-17 04:31:26.743 screenresolution[1663:10543] starting screenresolution argv=screenresolution get 04:31:26 INFO - 2017-04-17 04:31:26.745 screenresolution[1663:10543] Display 0: 1600x1200x32@60 04:31:26 INFO - 2017-04-17 04:31:26.751 screenresolution[1664:10545] starting screenresolution argv=screenresolution list 04:31:26 INFO - Available Modes on Display 0 04:31:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:31:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:31:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:31:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:31:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:31:26 INFO - Intel Iris: 04:31:26 INFO - Chipset Model: Intel Iris 04:31:26 INFO - Type: GPU 04:31:26 INFO - Bus: Built-In 04:31:26 INFO - VRAM (Dynamic, Max): 1536 MB 04:31:26 INFO - Vendor: Intel (0x8086) 04:31:26 INFO - Device ID: 0x0a2e 04:31:26 INFO - Revision ID: 0x0009 04:31:26 INFO - Displays: 04:31:26 INFO - Display: 04:31:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:31:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:31:26 INFO - Display Serial Number: 1600x1200 60 04:31:26 INFO - Main Display: Yes 04:31:26 INFO - Mirror: Off 04:31:26 INFO - Online: Yes 04:31:26 INFO - Rotation: Supported 04:31:26 INFO - Return code: 0 04:31:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:31:26 INFO - Python 2.7.3 04:31:26 INFO - Return code: 0 04:31:26 INFO - grabbing minidump binary from tooltool 04:31: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')]} 04:31:26 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 0x10df93d30>, '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 0x10deb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df88be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:31:26 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 04:31:26 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 04:31:26 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 04:31:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:31:27 INFO - Return code: 0 04:31:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:31:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:31:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:31:27 INFO - ENV: RUST_BACKTRACE is now 1 04:31:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:31:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:31:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nf1hrFrlQW6SHW1SOPBElQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0091', '--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 04:31:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Nf1hrFrlQW6SHW1SOPBElQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0091 --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 04:31:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.syg3UALygH/Render', 04:31:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:27 INFO - 'HOME': '/Users/cltbld', 04:31:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:27 INFO - 'LOGNAME': 'cltbld', 04:31:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:31:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:27 INFO - 'MOZ_NO_REMOTE': '1', 04:31:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:31:27 INFO - 'NO_EM_RESTART': '1', 04:31:27 INFO - 'PAGER': '/bin/cat', 04:31:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:27 INFO - 'PWD': '/builds/slave/test', 04:31:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:31:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:27 INFO - 'RUST_BACKTRACE': '1', 04:31:27 INFO - 'SHELL': '/bin/bash', 04:31:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nbgavzHhSS/Listeners', 04:31:27 INFO - 'TMPDIR': '/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/', 04:31:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:27 INFO - 'USER': 'cltbld', 04:31:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:27 INFO - 'XPC_FLAGS': '0x0', 04:31:27 INFO - 'XPC_SERVICE_NAME': '0', 04:31:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nf1hrFrlQW6SHW1SOPBElQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0091', '--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 04:31:27 INFO - mozversion application_buildid: 20170417030204 04:31:27 INFO - mozversion application_changeset: c697e756f738ce37abc56f31bfbc48f55625d617 04:31:27 INFO - mozversion application_display_name: Nightly 04:31:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:31:27 INFO - mozversion application_name: Firefox 04:31:27 INFO - mozversion application_remotingname: firefox 04:31:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:31:27 INFO - mozversion application_vendor: Mozilla 04:31:27 INFO - mozversion application_version: 55.0a1 04:31:27 INFO - mozversion platform_buildid: 20170417030204 04:31:27 INFO - mozversion platform_changeset: c697e756f738ce37abc56f31bfbc48f55625d617 04:31:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:31:27 INFO - mozversion platform_version: 55.0a1 04:31:27 INFO - using testdate: 1492428687 04:31:27 INFO - actual date: 1492428687 04:31:27 INFO - starting webserver on 'localhost:49245' 04:31:27 INFO - SUITE-START | Running 2 tests 04:31:27 INFO - TEST-START | dromaeo_css 04:31:27 INFO - operating with platform_type : mac_ 04:31:27 INFO - Initialising browser for dromaeo_css test... 04:31:27 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/tmpyJkanT/profile http://localhost:49245/getInfo.html) 04:31:30 INFO - PID 1674 | __metrics Screen width/height:1600/1200 04:31:30 INFO - PID 1674 | colorDepth:24 04:31:30 INFO - PID 1674 | Browser inner width/height: 1024/689 04:31:30 INFO - PID 1674 | __metrics 04:31:30 INFO - PID 1674 | 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:31:30 INFO - PID 1674 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:31:31 INFO - TEST-INFO | 1674: exit 0 04:31:31 INFO - Browser initialized. 04:31:31 INFO - Running cycle 1/1 for dromaeo_css test... 04:31:31 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/tmpyJkanT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:31:43 INFO - PID 1678 | RSS: Main: 240652288 04:31:43 INFO - PID 1678 | 04:34:48 INFO - PID 1678 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49245/tests/dromaeo/cssquery-ext.html) 04:34:50 INFO - PID 1678 | RSS: Main: 482811904 04:34:50 INFO - PID 1678 | 04:36:33 INFO - PID 1678 | ************************* 04:36:33 INFO - PID 1678 | A coding exception was thrown and uncaught in a Task. 04:36:33 INFO - PID 1678 | 04:36:33 ERROR - PID 1678 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:36:33 INFO - PID 1678 | Full stack: 04:36:33 INFO - PID 1678 | ************************* 04:36:33 INFO - PID 1678 | ************************* 04:36:33 INFO - PID 1678 | A coding exception was thrown and uncaught in a Task. 04:36:33 INFO - PID 1678 | 04:36:33 ERROR - PID 1678 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:36:33 INFO - PID 1678 | Full stack: 04:36:33 INFO - PID 1678 | ************************* 04:36:33 INFO - PID 1678 | ************************* 04:36:33 INFO - PID 1678 | A coding exception was thrown and uncaught in a Task. 04:36:33 INFO - PID 1678 | 04:36:33 ERROR - PID 1678 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:36:33 INFO - PID 1678 | Full stack: 04:36:33 INFO - PID 1678 | ************************* 04:36:33 INFO - PID 1678 | ************************* 04:36:33 INFO - PID 1678 | A coding exception was thrown and uncaught in a Task. 04:36:33 INFO - PID 1678 | 04:36:33 ERROR - PID 1678 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:36:33 INFO - PID 1678 | Full stack: 04:36:33 INFO - PID 1678 | ************************* 04:37:53 INFO - PID 1678 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-ext.html (next: http://localhost:49245/tests/dromaeo/cssquery-jquery.html) 04:37:54 INFO - PID 1678 | RSS: Main: 375619584 04:37:54 INFO - PID 1678 | 04:40:56 INFO - PID 1678 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49245/tests/dromaeo/cssquery-mootools.html) 04:40:57 INFO - PID 1678 | RSS: Main: 342769664 04:40:57 INFO - PID 1678 | 04:43:59 INFO - PID 1678 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49245/tests/dromaeo/cssquery-prototype.html) 04:44:00 INFO - PID 1678 | RSS: Main: 338866176 04:44:00 INFO - PID 1678 | 04:47:04 INFO - PID 1678 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49245/tests/dromaeo/cssquery-yui.html) 04:47:04 INFO - PID 1678 | RSS: Main: 333963264 04:47:04 INFO - PID 1678 | 04:50:07 INFO - PID 1678 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-yui.html (next: http://localhost:49245/tests/dromaeo/cssquery-dojo.html) 04:50:07 INFO - PID 1678 | RSS: Main: 377077760 04:50:07 INFO - PID 1678 | 04:50:07 INFO - PID 1678 | __start_tp_report 04:50:07 INFO - PID 1678 | _x_x_mozilla_page_load 04:50:07 INFO - PID 1678 | _x_x_mozilla_page_load_details 04:50:07 INFO - PID 1678 | |i|pagename|runs| 04:50:07 INFO - PID 1678 | |0;dojo.html;3486.1458942559043;3486.4944583035463;3489.3719130556487;3516.4901089342047;3548.1839176989292;5295.735213239337;5981.5214782817375;6036.124761909526;6111.266648002246;6222;6094.773429326507;6112.969435152818;6164.075388691698;6179.66011869347;6208.2239720034995;5114.43741188469;5333.413324534317;5362.946370536284;5364.356277246726;5384.488473595002;5445.482679145475;5472.91790623139;5480.835574932738;5484.396716361217;5547.77808887646;5244.8688782780355;5306.09796334624;5325.627206095575;5337.759800808973;5415.810446634388;5319.601029922733;5320.334958130234;5331.840044798662;5338.466153384669;5341.839744807662;5221.895562088775;5279.788808447657;5288.444713305124;5298.655587386807;5302.946970530284;6067.332593414721;6069.2716873975405;6071.301800292978;6078.6048906820915;6091.0863370494335;6331.8733625327695;6487.286398496161;6553.836154096138;6584.242812076624;6615.17310336208;6620.073189753439;6710.127683401127;6715.731370745164;6728.730850765964;6734.8316292092595;5206.843794686166;6268.153799237045;6274.529410294246;6294.464970477469;6294.590851594723;6523.988781738838;6629.569078009914;6640.435562977104;6691.330866913367;6801.18385793708;6219.533534984895;6314.273858506239;6315.210598675166;6503.479721622259;6527.640979746159;6386.393292637192;6386.872262554816;6390.201224846895;6390.840228994312;6410.519211059189;6322.0516922462;6334.904976425358;6497.220333559909;6582.24304205013;6619.404253617101;6505.349465053457;6514.283428822826;6519.576227545194;6530.706118224692;6546.050822630692;5184.455632158569;5238.345206849144;5285.127953887642;5291.894162116736;5297.046531624267;4689.155951928686;4699.2481203007355;4700.7179569225955;4702.6473014524045;4766.45185803637;6155.507559395238;6199.938000620026;6218.81343559694;6242.781502647385;6252.406021427957;6671.899921501182;6701.396874281338;6708.966455167791;6725.159355080615;6727.62998035103;6105.664188469588;6136.12084543884;6233.407826256498;6247.2815626202655;6258.499320054385;5761.88476230473;5822.534197264209;5856.385079566669;5910.231669882888;5924.11138329254;6784.118064651564;6794.286599907136;6795;6797.048413222153;6827.385535301648;6611.735530578723;6628.105205797156;6670.132882725215;6714.899276510954;6736.966315168393;6499.5125365598715;6613.603183808987;6715.4963377747845;6769;6769.796906092825;5495.505404513613;6296.874062518632;6464;6529.706163222571;6530.640814755044;6586.506012049212;6599.109120268702;6634.436072933661;6637.800865974028;6647.867042659023;6385.233771947396;6439.098526206429;6451.451626611791;6451.516136289703;6457.806265812033;6190.845228869134;6260.530460215411;6341.682915854281;6380.011098279774;6403.935960640334;6149.877002459836;6240.126382306572;6257.655828929453;6299.464545513682;6320.988641817287;6193.071039344134;6256.092866534418;6271.717772700148;6278.591891527219;6284.088807123033;5628.634138780966;5893.88016276906;6244.750209991549;6264.966280563838;6303.149074875017 04:50:07 INFO - PID 1678 | |1;ext.html;794.3168874767699;813.4549851599429;1121.4448847820331;1140.5836869542613;1145.9197856150072;36558;37141.25717485649;37262.8136859316;37387.87836364906;37399.439008414825;38353.61646383535;38711.838644840696;38724.41913371302;38775;38802.61197388025;6105.755769769204;6289.339619339972;8539.27416169628;8652.480851148952;8679.956600217021;8347.791305217357;8502.149785021511;8534.146585341477;8537.402381833273;8550.572471376407;8566.3146948244;8621.353398495106;8624.827503449927;8643.567821608895;8651.264642505395;8555.657773689045;8593.699220527315;8600.354973377021;8610.182032706884;8615.65537378504;8349.499030058156;8425.536595487245;8429.578521073983;8429.747107586782;8434.662613495453;37069;37321.440178397344;37339.87980360594;37395.25209495822;37586.060348491235;3623.2391197848483;3645.5989841117457;3666.6699997000396;3666.944995825065;3672.0452682302525;30250.54624180617;30343.24141896448;30380.84809575938;30402.847985760152;30408.087757367313;3113;3148;3172.159377764894;3186.5379519969706;3189.8245596492184;219395;290800.5459972708;292022;292255;293817.5309123462;31024.68975310263;40437;40494.79752601277;47317.29024064642;48393.75803120962;50410.49589504131;50673.74663126734;51103;51141.97716045658;51233;14021.369038393297;14096.436142554388;14145.151290922578;14159.221242831538;14163.85836141646;9656.22750179984;9813.950930245303;11401.771964560663;11413.459183010353;11420.486078126503;10783.406912619881;10883.727906802393;10887.401192934465;10912.236143469881;12237.816432753516;5275.525202731773;5355.625106242604;5355.732213389315;5373.167159090347;5387.595930305164;856.8843206167212;1018.1549314069305;1022.8056669232822;1023.457567489217;1070.8982646648556;22654.223173090755;24437.38906527351;24472.265832025067;24480;24994.875230614667;995.711243739322;1114.4483480677118;1116.7882847110975;1149.6378640728144;1157.1321508868348;12153.756924861631;12513.061520386007;12515.061370397256;12551.435185416496;12585.811212831815;243535;247031;247525;248064.75967620045;249044;52369.738151309;52747.208791867386;52772;52904.20643690348;52961.2055819163;1480.4818313590588;1508.8189417269998;1519.7416439205363;1523.4972459088474;1523.748581484065;23108.653370199125;26898;27298;27811.860940695165;28730.71269287364;36758.63241367552;36994.26011479701;36994.8150259247;37003;37086;229403;230294;230315;230595;231033.84483077476;33143.66856331406;34262;35256.823715881255;35376.469352960245;35390.292194156485;36744.08139796527;37630.62369376271;38313.85058448251;43282;46128.30807537823;28500.42999140047;28548;30268.84865575658;31304.74781008734;31589;29783.10650680483;30261.546076809307;30972.845135774176;31138.065858024296;31524.211894701897;36567.902962911154;36686.816565917;37210.06974825651;37258.254834903695;37328.62671373251;30531.84734076404;31238;31668.683313166573;31742.841285793424;31773.84113079512;21229.893850530647;22232.935399540795;22912;23003.194888178834;24354.63468048016 04:50:07 INFO - PID 1678 | |2;jquery.html;415.88147377997257;420.4345155765494;426.77167715272327;427.79893450078464;444.5088177563792;19166.52083697908;20844.478888027807;21667.566648667016;21764.238251661176;21856.125754969784;21318.040688169032;21911.67132493014;22065.558688826215;22167.78077205753;22395.888020559876;5961.195238642782;6289.0252010938375;6294.2761582417925;6305.747770089191;6305.905411418832;5916.408359164071;6141.692915354237;6171.290301615327;6215.782447614334;6221.813345599639;6010.36891126432;6167.383261673819;6186;6188.226471691039;6193.318734939153;6037.849053773647;6171.6297022178815;6173.69131543421;6184.690765461709;6185;5374.328208973879;5483.561315094783;5487.506124448819;5497.890042199134;5550.389457159709;27507.58738618922;27564.86217568899;27690.030848920393;28095.15714528547;28423.85788071067;2092.7384076990375;2161.275972549198;2164.3290579920117;2167.5556510915226;2170.934871953828;17469.301227950866;17626.823731762648;17678.646427071515;18210.90894545532;18422.90788546049;1808.4755420927916;1836.6602178596868;2120.257909731597;2152.182170775111;2152.2682288022147;149778;150467;151760;152288;154523;10306.33008854422;11398.430078496041;11960.222585531912;12022.939885300517;12196.756064878653;15992.36030558788;15997.960387526333;16001.359945602278;16009.679806403807;16040.117793521234;7187.496875218684;7381.8154546136775;8465.153484651608;8800.823983520293;8952.507612081397;8355.206255405727;8362.498250105013;8373.288270496954;8550.82898342042;8559.101294364002;7556.735514256975;7674.774315448569;7722.150563438017;7746.38028957682;7749.496282741717;1723.7069698151345;2049.549099198174;2057.8289904151266;2066.5660211355485;2190.1677362602427;951.6098399656108;957.3585697582637;960.7598100474881;989.7179303898355;993.9105480506645;20998.265060722802;21360.93195340227;21382.893085534783;21559.461013474476;21650.783492165192;896.4486840592988;984.542187882638;1001.689476262361;1011.3426272922659;1023.0970395065173;10480.056794888344;10860.72848178786;10935.507902144423;10938.179636527293;10943.507542160622;595705;595812;599461.008084879;610812;614699;95540;102421.4636780449;118640;118834;137566;1083.1876092930302;1157.9826302605468;1247.8190662354089;1279.9744005119846;1295.6242689620094;19013.71479427782;20958.056887440405;20996.790032100096;22879.856007199905;22911.656325154803;56542.80129381299;57425;57480;58037.42382506839;58457;81727;82038.58980705058;82408.76386854082;82436.17563824524;83087.75368369359;12819.871801281868;12947.158434701714;13066.869331306565;13475.865241347461;13476.460941562227;14099.295035248402;14341.92829035848;14432.639184020483;14465.540858054366;14608.853911461174;11616.186866919235;11859.822102668295;12068.51725930988;12090.214136081127;12103.878961210276;11145.55417783312;11289.491972861077;11534.654950064387;11677.941610291895;11814.645560633195;11541.480633371351;11967.880321196677;12124.636260912186;12282.877171228174;12325.260484370967;12095.637130886087;13117.147385419918;13190.538331158363;13197.294554616088;13210;11764.352960586908;11770.82343764827;12032.879671203176;12045.457954391899;12150.088743344108 04:50:07 INFO - PID 1678 | |3;mootools.html;1279.1877158004668;1403.7262733766913;1467.8972471926963;1491.358715752226;1502.5867886331264;11202.831957520644;11710.180287379886;11710.882891171106;11715.941420292907;11718.882811171896;9287.907120928789;11514.309141451498;11833.467493962771;11850.288982661046;11873.643790686294;2089.4045197118826;2180.767866155617;2501.6872890888685;2545.770880620744;2548.3501707064675;2009.9698504522444;2380.5476959377747;2531.999860055277;2534.3664083979006;2537.2768760903145;1735;2189.8467107302495;2192.024549075662;2192.495725983025;2194.1552502286654;2155.6012137754565;2429.963550546743;2524.8106392020673;2524.962125568118;2526.84838909666;2500.3374105861963;2505.5740524110943;2528.8735563221767;2542.7075886272946;2542.8474291542566;11856.466459009365;11986.280823150639;11991.64025079249;12000.339981301026;12029;6466.385693359123;6712;6722.226943901416;6727.562708423937;6729.293424190488;3538.6638269364626;4015.2371049500503;4251.829926802955;4334.6592839866435;4335.891602709926;1212.8847759462838;1229.5450683247257;1271.7456508698297;1276.9170003949807;1278.7826069568196;16462.341506339733;16528.83471165297;16546.66906661872;16576.917115414468;16587.83412165887;4389.736615803062;5328.760205790749;5518.806841760519;5526.447355264522;5581.748821303051;12357;12381.690457738448;12397.814032789516;12407.193532420364;12408.19346742477;6498.252700939453;6509.381608747161;6510.641914694643;6514.022896565459;6516.022596610546;5162.97418512905;5806.809604031164;6077.179580756541;6113.724882380304;6201.81394558164;4306.80619372129;4393.340998850134;4424.6902716810155;4456.844010459618;4458.331250312479;1257.2770656872335;1269.5873841001712;1275.8213850061;1293.0948336164722;1300.6228193823686;713.3579778199662;770.8419773946327;791.1258059843905;796.283344989514;799.4523751230425;6642.615873523451;6717;6864.450843932474;6893.896591551131;6983.336583024706;899.9010108888017;903.408267584733;918.2883265469181;939.5067589515559;964.5514835601479;4049.635532802062;4104.18310970794;4150.730202536825;4333.58830911063;4352.760598167068;14253.144811311355;14782.704345913236;14823.332950017275;14824.3329050193;14828.555143345717;14517.637059073397;14570.19863907474;14888.925555372154;14914.776278355834;14942.626434339229;8139.348852091818;8272.420930534805;8317.584120793936;8321.292690121407;8327.50034997902;5537.944620553743;6063.636181829104;6523.086767852409;6529.661419409104;6785.389314961677;10264.384136951807;12605.87394126047;13217.074804763573;13222.867771322548;13259;12251.38743062861;13592.45630174782;13596.66008349799;13615.115017523829;13814.723705526034;9130.269578433843;9503.144716975505;9517.714468565953;9520.571574279313;9534.95232523833;10252.794944100928;10558.8416173759;10654.360738355723;10687.732806679895;10724.195685323475;9116;9159.450432974043;9171.35800493959;9184.49485278316;9196.218321442751;8823.602937867683;8879.600417981077;8898.154675305836;8901.154390332907;8949;7889.921100788919;8032.196780321921;8032.959835200787;8042.276195142465;8047.919520804717;5905.379935106752;5925.229720136527;6058.363871793398;6111.266648002268;6144.078388241799;5541.916871246854;5735.369109398046;6093.421124993119;6112.969435152796;6314 04:50:07 INFO - PID 1678 | |4;prototype.html;379.87654012445955;382.48364707644663;389.3750530398712;389.5092183848351;392.8762439831453;4691.061787642472;4721.527847215277;5686.147077938306;5738.3974682658345;5756.165356023374;5491.28613280273;5604.898163188805;5613.46672066154;5624.943750562493;5667.433256674331;4149.398337241113;4274.465691788527;4313.762743049131;4332.826686932519;4364.236258654731;3710.499082623838;4194.266003449399;4247.787610619472;4252.596003379689;4266.893327666818;3505.7020153287003;3551.147724546116;4180.811863466151;4210.063370849413;4244.660427165834;3700.5374328208973;4228.9154216915485;4244.745315281062;4248.150369926012;4271.9359209611885;3025.243689077731;3089.675584063686;3503.6671516206175;3679.6504332088407;3697.3563901810335;5539.362973258087;5560.49866536033;5568.805091821807;5595.63628364155;5604.719764011783;4712.939588592573;4999.7750101245165;5006.824761133379;5010.323606313137;5013.398392192924;4556;5310.9734451327495;6071.271447426293;6105.267367915834;6153.600015998991;3340.1816554943953;3581.94627080594;4113.115680128757;4130.731502452331;4136.110736191733;6185.175373264853;6215.96892015537;6382.68086595673;6385.936140638627;6509;3535.876244331436;3575.606683264839;3714.6285371463177;4017.658499027557;4227.7040607157205;4293.613574778223;4295;4297.247981603207;4305.16049370376;4324.091940692427;4740.5733483986605;4834.903301933941;4983.377077865267;5011.747063234191;5043.84868453947;5039.807683657621;5662.85842853932;5975.671338076448;6224.782132625336;6231.345708700612;1208.4984731336572;1456.155429850684;1462.4515806572535;1464.633841539615;1468.7062587482546;891.140049851896;931.4225180388203;962.0379620379621;985.4235272365746;994.4182653147844;4682.74244916526;4928.950710492849;5829;5863.208466857005;5893.882122357529;5644.774209031675;6403.911335073049;6405.615663060231;6419.878853250641;6435.967820160869;5324.7753016806355;5571.8269874748885;5749.3778919280585;5796.188533605298;5800;2794.5389010813396;2918.562215667667;2926.5024945759274;3034.9393012139635;3345.0633822529244;5284.445133261029;5641.633293835887;6198.566100372931;6254.937450625435;6485.319041500669;5688.720037991418;6455.741770329134;6504.577202481918;6515.218173819172;6523.249131749263;5309.354100228941;6518.641474718841;6526.706298216592;6531;6533.18335208099;5505.449455054622;5530.668159910419;5672.376038635829;6327.272363678052;6375.458086062551;6325.525585581192;6329.620222786648;6347.904781428375;6372.490200784019;6375;6114.602550834182;6447.742090316335;6485.967570162119;6527.412532872065;6545.934540654533;4140.585941405835;4578.633709303314;4632.328312394617;4642.187617166915;4643.976780116078;4883;5381.273528073816;6196;6337.144485494584;6405.843296146647;4507.887302817456;5911.467967882739;6054.218221598275;6228.937710622836;6254.718537665907;4784.976075119741;5296.735163241746;5458.372287186866;6204.790065937099;6253.49860055963;4859.659823812441;5310.044192045469;5782.653040817564;6093.116498107838;6112;5174.663646862942;6207.379262073757;6227.50179985591;6280.497560195082;6307;5907.32065812437;6019.404857712622;6088.665123418255;6105.931461994044;6222.81331560054 04:50:07 INFO - PID 1678 | |5;yui.html;716.0869890889119;731.2869951796998;858.7037472072133;869.2524428991071;880.0759202837022;13500.257485838274;18075.72886406705;18822.52943676409;18825.529361765963;18871.905640471814;17366;17683.73474397885;17854.196561154746;17862.732059019094;17889.552761180978;968.1770495079179;1003.523326419952;1005.7385079879248;1007.0986467111967;1007.8588997540351;673.636236432326;690.3924546399187;691.4710246661308;693.2616763147232;694.1150033707039;987.2743533502905;1017.0795430135702;1025.7743296474764;1026.1124127629585;1026.9743256418612;1018.9592416303376;1019.2457581389792;1021.4688362051729;1024.933379330341;1026.3687831983352;755.0147058089192;756.0134025097246;756.3646536908968;758.6206896551724;759.3166150464571;16847.66304673912;16986.66026679472;17165.05592192429;17313.480595582027;17602.647947041114;17224.569385765455;17239.138043097795;17411.65176696472;17582.824171758373;17672.293108275782;13895.861041389559;14164.150150990974;14175.503857364944;14392.992490525667;14412.063215890934;3404.4042292598697;3433.5536380270655;3435.587729472479;3435.656434356569;3436.347094052122;118363;119817;120760;121777;122084.38957805243;10855.891441085489;12070.818937715942;12412.937935310265;12413.06901982355;13506.527271545448;20103.597928041356;24849.39683745883;25141.622875656878;25466.74533254681;25541.97832086733;7521.811954701177;7532.811679708051;7610;7615.657295421719;7617.085949685962;3064.586280852101;3842.3852183650483;3844.884653460401;3850.268448994682;3854.3062248794927;4307.547707490731;4403.735775853395;4413.16149931512;4424.11517696462;4426;867.5618812499773;884.5621417398429;887.0863011098579;888.9066648001996;890.8485557455248;651.4853265919965;656.74715234635;668.4418510543751;681.7477533312706;682.1916029505053;11037.337759734442;11447.713807154722;11899.226550274205;11908.642740717793;12092.758144837055;648.8994205898093;659.3571268013649;663.8008597420754;663.8771827211981;674.1573033707865;5298.231756395301;5310.389305229871;5445.9727701362035;5520.66875987442;5576.247206627135;99924;100034;100534;106972.46513767538;108844.58486642099;91432;92611.53694231485;92620.05349598672;93928;95990.52004739932;60135;82860.58569707113;84449;84774.57612711897;85657.57171214104;10491.790164196826;10784.029437350677;10990.780184396108;11093.722656933642;11134.27627204229;33253.33493330168;41342.793286033375;41373.586264136975;42657.5734242666;42776.5722342785;54178.72910635579;54228.72885635705;55078;55348.44651553433;56247.71876140593;12761.042921780718;14462.85537144615;14697;14728.55814325572;14738.63153421173;15442.0734755915;15953.361865525714;15974.680506389575;15986.280617372478;16002.439914602934;14245.64385890361;14472.638184045483;14500.709985800015;14604.488842890873;14702.55892323232;14464.421423142956;14594.562163135122;14653.413863445769;14746.967712260039;14805.259737013323;14069;14261.358238879482;14365.281735913371;14409.78385324242;14591.854081459474;10700.518476668412;10897.455127243447;10962.506687198937;11033.834492482458;11073.335599864035;11668.94165529167;11791.823122653339;11813.350265735467;11895.702607434883;12053.879461205275 04:50:07 INFO - PID 1678 | __end_tp_report 04:50:07 INFO - PID 1678 | __start_cc_report 04:50:07 INFO - PID 1678 | _x_x_mozilla_cycle_collect,2836 04:50:07 INFO - PID 1678 | __end_cc_report 04:50:07 INFO - PID 1678 | __startTimestamp1492429807402__endTimestamp 04:50:07 INFO - PID 1678 | 04:50:07 INFO - PID 1678 | ------- Summary: start ------- 04:50:07 INFO - PID 1678 | Number of tests: 6 04:50:07 INFO - PID 1678 | 04:50:07 INFO - PID 1678 | [#0] dojo.html Cycles:165 Average:6042.51 Median:6260.53 stddev:702.86 (11.2%) stddev-sans-first:675.80 04:50:07 INFO - PID 1678 | Values: 3486.1 3486.5 3489.4 3516.5 3548.2 5295.7 5981.5 6036.1 6111.3 6222.0 6094.8 6113.0 6164.1 6179.7 6208.2 5114.4 5333.4 5362.9 5364.4 5384.5 5445.5 5472.9 5480.8 5484.4 5547.8 5244.9 5306.1 5325.6 5337.8 5415.8 5319.6 5320.3 5331.8 5338.5 5341.8 5221.9 5279.8 5288.4 5298.7 5302.9 6067.3 6069.3 6071.3 6078.6 6091.1 6331.9 6487.3 6553.8 6584.2 6615.2 6620.1 6710.1 6715.7 6728.7 6734.8 5206.8 6268.2 6274.5 6294.5 6294.6 6524.0 6629.6 6640.4 6691.3 6801.2 6219.5 6314.3 6315.2 6503.5 6527.6 6386.4 6386.9 6390.2 6390.8 6410.5 6322.1 6334.9 6497.2 6582.2 6619.4 6505.3 6514.3 6519.6 6530.7 6546.1 5184.5 5238.3 5285.1 5291.9 5297.0 4689.2 4699.2 4700.7 4702.6 4766.5 6155.5 6199.9 6218.8 6242.8 6252.4 6671.9 6701.4 6709.0 6725.2 6727.6 6105.7 6136.1 6233.4 6247.3 6258.5 5761.9 5822.5 5856.4 5910.2 5924.1 6784.1 6794.3 6795.0 6797.0 6827.4 6611.7 6628.1 6670.1 6714.9 6737.0 6499.5 6613.6 6715.5 6769.0 6769.8 5495.5 6296.9 6464.0 6529.7 6530.6 6586.5 6599.1 6634.4 6637.8 6647.9 6385.2 6439.1 6451.5 6451.5 6457.8 6190.8 6260.5 6341.7 6380.0 6403.9 6149.9 6240.1 6257.7 6299.5 6321.0 6193.1 6256.1 6271.7 6278.6 6284.1 5628.6 5893.9 6244.8 6265.0 6303.1 04:50:07 INFO - PID 1678 | 04:50:07 INFO - PID 1678 | [#1] ext.html Cycles:180 Average:40715.26 Median:33702.83 stddev:65997.06 (195.8%) stddev-sans-first:66114.13 04:50:07 INFO - PID 1678 | Values: 794.3 813.5 1121.4 1140.6 1145.9 36558.0 37141.3 37262.8 37387.9 37399.4 38353.6 38711.8 38724.4 38775.0 38802.6 6105.8 6289.3 8539.3 8652.5 8680.0 8347.8 8502.1 8534.1 8537.4 8550.6 8566.3 8621.4 8624.8 8643.6 8651.3 8555.7 8593.7 8600.4 8610.2 8615.7 8349.5 8425.5 8429.6 8429.7 8434.7 37069.0 37321.4 37339.9 37395.3 37586.1 3623.2 3645.6 3666.7 3666.9 3672.0 30250.5 30343.2 30380.8 30402.8 30408.1 3113.0 3148.0 3172.2 3186.5 3189.8 219395.0 290800.5 292022.0 292255.0 293817.5 31024.7 40437.0 40494.8 47317.3 48393.8 50410.5 50673.7 51103.0 51142.0 51233.0 14021.4 14096.4 14145.2 14159.2 14163.9 9656.2 9814.0 11401.8 11413.5 11420.5 10783.4 10883.7 10887.4 10912.2 12237.8 5275.5 5355.6 5355.7 5373.2 5387.6 856.9 1018.2 1022.8 1023.5 1070.9 22654.2 24437.4 24472.3 24480.0 24994.9 995.7 1114.4 1116.8 1149.6 1157.1 12153.8 12513.1 12515.1 12551.4 12585.8 243535.0 247031.0 247525.0 248064.8 249044.0 52369.7 52747.2 52772.0 52904.2 52961.2 1480.5 1508.8 1519.7 1523.5 1523.7 23108.7 26898.0 27298.0 27811.9 28730.7 36758.6 36994.3 36994.8 37003.0 37086.0 229403.0 230294.0 230315.0 230595.0 231033.8 33143.7 34262.0 35256.8 35376.5 35390.3 36744.1 37630.6 38313.9 43282.0 46128.3 28500.4 28548.0 30268.8 31304.7 31589.0 29783.1 30261.5 30972.8 31138.1 31524.2 36567.9 36686.8 37210.1 37258.3 37328.6 30531.8 31238.0 31668.7 31742.8 31773.8 21229.9 22232.9 22912.0 23003.2 24354.6 04:50:07 INFO - PID 1678 | 04:50:07 INFO - PID 1678 | [#2] jquery.html Cycles:180 Average:36991.01 Median:11855.86 stddev:101139.51 (853.1%) stddev-sans-first:101385.95 04:50:07 INFO - PID 1678 | Values: 415.9 420.4 426.8 427.8 444.5 19166.5 20844.5 21667.6 21764.2 21856.1 21318.0 21911.7 22065.6 22167.8 22395.9 5961.2 6289.0 6294.3 6305.7 6305.9 5916.4 6141.7 6171.3 6215.8 6221.8 6010.4 6167.4 6186.0 6188.2 6193.3 6037.8 6171.6 6173.7 6184.7 6185.0 5374.3 5483.6 5487.5 5497.9 5550.4 27507.6 27564.9 27690.0 28095.2 28423.9 2092.7 2161.3 2164.3 2167.6 2170.9 17469.3 17626.8 17678.6 18210.9 18422.9 1808.5 1836.7 2120.3 2152.2 2152.3 149778.0 150467.0 151760.0 152288.0 154523.0 10306.3 11398.4 11960.2 12022.9 12196.8 15992.4 15998.0 16001.4 16009.7 16040.1 7187.5 7381.8 8465.2 8800.8 8952.5 8355.2 8362.5 8373.3 8550.8 8559.1 7556.7 7674.8 7722.2 7746.4 7749.5 1723.7 2049.5 2057.8 2066.6 2190.2 951.6 957.4 960.8 989.7 993.9 20998.3 21360.9 21382.9 21559.5 21650.8 896.4 984.5 1001.7 1011.3 1023.1 10480.1 10860.7 10935.5 10938.2 10943.5 595705.0 595812.0 599461.0 610812.0 614699.0 95540.0 102421.5 118640.0 118834.0 137566.0 1083.2 1158.0 1247.8 1280.0 1295.6 19013.7 20958.1 20996.8 22879.9 22911.7 56542.8 57425.0 57480.0 58037.4 58457.0 81727.0 82038.6 82408.8 82436.2 83087.8 12819.9 12947.2 13066.9 13475.9 13476.5 14099.3 14341.9 14432.6 14465.5 14608.9 11616.2 11859.8 12068.5 12090.2 12103.9 11145.6 11289.5 11534.7 11677.9 11814.6 11541.5 11967.9 12124.6 12282.9 12325.3 12095.6 13117.1 13190.5 13197.3 13210.0 11764.4 11770.8 12032.9 12045.5 12150.1 04:50:07 INFO - PID 1678 | 04:50:07 INFO - PID 1678 | [#3] mootools.html Cycles:180 Average:7030.93 Median:4032.44 stddev:4479.88 (111.1%) stddev-sans-first:4471.60 04:50:07 INFO - PID 1678 | Values: 1279.2 1403.7 1467.9 1491.4 1502.6 11202.8 11710.2 11710.9 11715.9 11718.9 9287.9 11514.3 11833.5 11850.3 11873.6 2089.4 2180.8 2501.7 2545.8 2548.4 2010.0 2380.5 2532.0 2534.4 2537.3 1735.0 2189.8 2192.0 2192.5 2194.2 2155.6 2430.0 2524.8 2525.0 2526.8 2500.3 2505.6 2528.9 2542.7 2542.8 11856.5 11986.3 11991.6 12000.3 12029.0 6466.4 6712.0 6722.2 6727.6 6729.3 3538.7 4015.2 4251.8 4334.7 4335.9 1212.9 1229.5 1271.7 1276.9 1278.8 16462.3 16528.8 16546.7 16576.9 16587.8 4389.7 5328.8 5518.8 5526.4 5581.7 12357.0 12381.7 12397.8 12407.2 12408.2 6498.3 6509.4 6510.6 6514.0 6516.0 5163.0 5806.8 6077.2 6113.7 6201.8 4306.8 4393.3 4424.7 4456.8 4458.3 1257.3 1269.6 1275.8 1293.1 1300.6 713.4 770.8 791.1 796.3 799.5 6642.6 6717.0 6864.5 6893.9 6983.3 899.9 903.4 918.3 939.5 964.6 4049.6 4104.2 4150.7 4333.6 4352.8 14253.1 14782.7 14823.3 14824.3 14828.6 14517.6 14570.2 14888.9 14914.8 14942.6 8139.3 8272.4 8317.6 8321.3 8327.5 5537.9 6063.6 6523.1 6529.7 6785.4 10264.4 12605.9 13217.1 13222.9 13259.0 12251.4 13592.5 13596.7 13615.1 13814.7 9130.3 9503.1 9517.7 9520.6 9535.0 10252.8 10558.8 10654.4 10687.7 10724.2 9116.0 9159.5 9171.4 9184.5 9196.2 8823.6 8879.6 8898.2 8901.2 8949.0 7889.9 8032.2 8033.0 8042.3 8047.9 5905.4 5925.2 6058.4 6111.3 6144.1 5541.9 5735.4 6093.4 6113.0 6314.0 04:50:07 INFO - PID 1678 | 04:50:07 INFO - PID 1678 | [#4] prototype.html Cycles:180 Average:4886.05 Median:5518.06 stddev:1554.11 (28.2%) stddev-sans-first:1521.22 04:50:07 INFO - PID 1678 | Values: 379.9 382.5 389.4 389.5 392.9 4691.1 4721.5 5686.1 5738.4 5756.2 5491.3 5604.9 5613.5 5624.9 5667.4 4149.4 4274.5 4313.8 4332.8 4364.2 3710.5 4194.3 4247.8 4252.6 4266.9 3505.7 3551.1 4180.8 4210.1 4244.7 3700.5 4228.9 4244.7 4248.2 4271.9 3025.2 3089.7 3503.7 3679.7 3697.4 5539.4 5560.5 5568.8 5595.6 5604.7 4712.9 4999.8 5006.8 5010.3 5013.4 4556.0 5311.0 6071.3 6105.3 6153.6 3340.2 3581.9 4113.1 4130.7 4136.1 6185.2 6216.0 6382.7 6385.9 6509.0 3535.9 3575.6 3714.6 4017.7 4227.7 4293.6 4295.0 4297.2 4305.2 4324.1 4740.6 4834.9 4983.4 5011.7 5043.8 5039.8 5662.9 5975.7 6224.8 6231.3 1208.5 1456.2 1462.5 1464.6 1468.7 891.1 931.4 962.0 985.4 994.4 4682.7 4929.0 5829.0 5863.2 5893.9 5644.8 6403.9 6405.6 6419.9 6436.0 5324.8 5571.8 5749.4 5796.2 5800.0 2794.5 2918.6 2926.5 3034.9 3345.1 5284.4 5641.6 6198.6 6254.9 6485.3 5688.7 6455.7 6504.6 6515.2 6523.2 5309.4 6518.6 6526.7 6531.0 6533.2 5505.4 5530.7 5672.4 6327.3 6375.5 6325.5 6329.6 6347.9 6372.5 6375.0 6114.6 6447.7 6486.0 6527.4 6545.9 4140.6 4578.6 4632.3 4642.2 4644.0 4883.0 5381.3 6196.0 6337.1 6405.8 4507.9 5911.5 6054.2 6228.9 6254.7 4785.0 5296.7 5458.4 6204.8 6253.5 4859.7 5310.0 5782.7 6093.1 6112.0 5174.7 6207.4 6227.5 6280.5 6307.0 5907.3 6019.4 6088.7 6105.9 6222.8 04:50:07 INFO - PID 1678 | 04:50:07 INFO - PID 1678 | [#5] yui.html Cycles:180 Average:21213.49 Median:17858.46 stddev:30235.13 (169.3%) stddev-sans-first:30280.78 04:50:07 INFO - PID 1678 | Values: 716.1 731.3 858.7 869.3 880.1 13500.3 18075.7 18822.5 18825.5 18871.9 17366.0 17683.7 17854.2 17862.7 17889.6 968.2 1003.5 1005.7 1007.1 1007.9 673.6 690.4 691.5 693.3 694.1 987.3 1017.1 1025.8 1026.1 1027.0 1019.0 1019.2 1021.5 1024.9 1026.4 755.0 756.0 756.4 758.6 759.3 16847.7 16986.7 17165.1 17313.5 17602.6 17224.6 17239.1 17411.7 17582.8 17672.3 13895.9 14164.2 14175.5 14393.0 14412.1 3404.4 3433.6 3435.6 3435.7 3436.3 118363.0 119817.0 120760.0 121777.0 122084.4 10855.9 12070.8 12412.9 12413.1 13506.5 20103.6 24849.4 25141.6 25466.7 25542.0 7521.8 7532.8 7610.0 7615.7 7617.1 3064.6 3842.4 3844.9 3850.3 3854.3 4307.5 4403.7 4413.2 4424.1 4426.0 867.6 884.6 887.1 888.9 890.8 651.5 656.7 668.4 681.7 682.2 11037.3 11447.7 11899.2 11908.6 12092.8 648.9 659.4 663.8 663.9 674.2 5298.2 5310.4 5446.0 5520.7 5576.2 99924.0 100034.0 100534.0 106972.5 108844.6 91432.0 92611.5 92620.1 93928.0 95990.5 60135.0 82860.6 84449.0 84774.6 85657.6 10491.8 10784.0 10990.8 11093.7 11134.3 33253.3 41342.8 41373.6 42657.6 42776.6 54178.7 54228.7 55078.0 55348.4 56247.7 12761.0 14462.9 14697.0 14728.6 14738.6 15442.1 15953.4 15974.7 15986.3 16002.4 14245.6 14472.6 14500.7 14604.5 14702.6 14464.4 14594.6 14653.4 14747.0 14805.3 14069.0 14261.4 14365.3 14409.8 14591.9 10700.5 10897.5 10962.5 11033.8 11073.3 11668.9 11791.8 11813.4 11895.7 12053.9 04:50:07 INFO - PID 1678 | -------- Summary: end -------- 04:50:07 INFO - PID 1678 | 04:50:08 INFO - TEST-INFO | 1678: exit 0 04:50:08 INFO - TEST-OK | dromaeo_css | took 1120827ms 04:50:08 INFO - TEST-START | kraken 04:50:08 INFO - operating with platform_type : mac_ 04:50:08 INFO - Initialising browser for kraken test... 04:50:08 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/tmpPn2ni7/profile http://localhost:49245/getInfo.html) 04:50:10 INFO - PID 1686 | __metrics Screen width/height:1600/1200 04:50:10 INFO - PID 1686 | colorDepth:24 04:50:10 INFO - PID 1686 | Browser inner width/height: 1024/689 04:50:10 INFO - PID 1686 | __metrics 04:50:10 INFO - PID 1686 | 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:50:10 INFO - PID 1686 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:50:11 INFO - TEST-INFO | 1686: exit 0 04:50:11 INFO - Browser initialized. 04:50:11 INFO - Running cycle 1/1 for kraken test... 04:50:11 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/T/tmpPn2ni7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:50:24 INFO - PID 1687 | RSS: Main: 241926144 04:50:24 INFO - PID 1687 | 04:50:26 INFO - PID 1687 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection) 04:50:27 INFO - PID 1687 | RSS: Main: 312623104 04:50:27 INFO - PID 1687 | 04:50:30 INFO - PID 1687 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-dft) 04:50:31 INFO - PID 1687 | RSS: Main: 293662720 04:50:31 INFO - PID 1687 | 04:50:34 INFO - PID 1687 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-fft) 04:50:35 INFO - PID 1687 | RSS: Main: 386936832 04:50:35 INFO - PID 1687 | 04:50:37 INFO - PID 1687 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator) 04:50:37 INFO - PID 1687 | RSS: Main: 289095680 04:50:37 INFO - PID 1687 | 04:50:39 INFO - PID 1687 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:50:40 INFO - PID 1687 | RSS: Main: 291667968 04:50:40 INFO - PID 1687 | 04:50:43 INFO - PID 1687 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom) 04:50:43 INFO - PID 1687 | RSS: Main: 355168256 04:50:43 INFO - PID 1687 | 04:50:46 INFO - PID 1687 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate) 04:50:47 INFO - PID 1687 | RSS: Main: 368709632 04:50:47 INFO - PID 1687 | 04:50:49 INFO - PID 1687 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial) 04:50:50 INFO - PID 1687 | RSS: Main: 373202944 04:50:50 INFO - PID 1687 | 04:50:52 INFO - PID 1687 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:50:52 INFO - PID 1687 | RSS: Main: 332529664 04:50:52 INFO - PID 1687 | 04:50:54 INFO - PID 1687 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:50:55 INFO - PID 1687 | RSS: Main: 334860288 04:50:55 INFO - PID 1687 | 04:50:57 INFO - PID 1687 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:50:57 INFO - PID 1687 | RSS: Main: 338046976 04:50:57 INFO - PID 1687 | 04:51:00 INFO - PID 1687 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:51:01 INFO - PID 1687 | RSS: Main: 351764480 04:51:01 INFO - PID 1687 | 04:51:04 INFO - PID 1687 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:51:05 INFO - PID 1687 | RSS: Main: 344223744 04:51:05 INFO - PID 1687 | 04:51:07 INFO - PID 1687 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49245/tests/kraken/driver.html?testName=ai-astar) 04:51:07 INFO - PID 1687 | RSS: Main: 386613248 04:51:07 INFO - PID 1687 | 04:51:07 INFO - PID 1687 | __start_tp_report 04:51:07 INFO - PID 1687 | _x_x_mozilla_page_load 04:51:07 INFO - PID 1687 | _x_x_mozilla_page_load_details 04:51:07 INFO - PID 1687 | |i|pagename|runs| 04:51:07 INFO - PID 1687 | |0;ai-astar;111;109;111;111;111;111;111;118;164;153 04:51:07 INFO - PID 1687 | |1;audio-beat-detection;142;111;109;149;111;112;123;140;150;110 04:51:07 INFO - PID 1687 | |2;audio-dft;189;185;185;187;187;187;182;182;186;187 04:51:07 INFO - PID 1687 | |3;audio-fft;77;61;57;87;61;59;60;59;83;57 04:51:07 INFO - PID 1687 | |4;audio-oscillator;91;69;83;71;70;73;90;68;69;89 04:51:07 INFO - PID 1687 | |5;imaging-gaussian-blur;86;86;87;85;88;86;87;86;86;86 04:51:07 INFO - PID 1687 | |6;imaging-darkroom;94;93;93;94;94;94;94;95;94;93 04:51:07 INFO - PID 1687 | |7;imaging-desaturate;85;86;87;86;84;84;85;83;85;86 04:51:07 INFO - PID 1687 | |8;json-parse-financial;50;49;49;49;48;49;49;51;49;48 04:51:07 INFO - PID 1687 | |9;json-stringify-tinderbox;55;61;55;57;66;58;57;57;58;58 04:51:07 INFO - PID 1687 | |10;stanford-crypto-aes;83;81;84;82;81;81;83;82;82;82 04:51:07 INFO - PID 1687 | |11;stanford-crypto-ccm;136;138;136;140;137;157;145;148;186;134 04:51:07 INFO - PID 1687 | |12;stanford-crypto-pbkdf2;182;186;185;185;187;186;182;190;182;182 04:51:07 INFO - PID 1687 | |13;stanford-crypto-sha256-iterative;69;68;67;67;66;68;67;66;66;67 04:51:07 INFO - PID 1687 | __end_tp_report 04:51:07 INFO - PID 1687 | __start_cc_report 04:51:07 INFO - PID 1687 | _x_x_mozilla_cycle_collect,2169 04:51:07 INFO - PID 1687 | __end_cc_report 04:51:07 INFO - PID 1687 | __startTimestamp1492429867343__endTimestamp 04:51:07 INFO - PID 1687 | 04:51:07 INFO - PID 1687 | ------- Summary: start ------- 04:51:07 INFO - PID 1687 | Number of tests: 14 04:51:07 INFO - PID 1687 | 04:51:07 INFO - PID 1687 | [#0] ai-astar Cycles:10 Average:121.00 Median:111.00 stddev:20.07 (18.1%) stddev-sans-first:20.96 04:51:07 INFO - PID 1687 | Values: 111.0 109.0 111.0 111.0 111.0 111.0 111.0 118.0 164.0 153.0 04:51:07 INFO - PID 1687 | 04:51:07 INFO - PID 1687 | [#1] audio-beat-detection Cycles:10 Average:125.70 Median:131.50 stddev:17.50 (13.3%) stddev-sans-first:17.54 04:51:07 INFO - PID 1687 | Values: 142.0 111.0 109.0 149.0 111.0 112.0 123.0 140.0 150.0 110.0 04:51:07 INFO - PID 1687 | 04:51:07 INFO - PID 1687 | [#2] audio-dft Cycles:10 Average:185.70 Median:187.00 stddev:2.26 (1.2%) stddev-sans-first:2.06 04:51:07 INFO - PID 1687 | Values: 189.0 185.0 185.0 187.0 187.0 187.0 182.0 182.0 186.0 187.0 04:51:07 INFO - PID 1687 | 04:51:07 INFO - PID 1687 | [#3] audio-fft Cycles:10 Average:66.10 Median:61.00 stddev:11.53 (18.9%) stddev-sans-first:11.54 04:51:07 INFO - PID 1687 | Values: 77.0 61.0 57.0 87.0 61.0 59.0 60.0 59.0 83.0 57.0 04:51:07 INFO - PID 1687 | 04:51:07 INFO - PID 1687 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:78.00 stddev:9.74 (12.5%) stddev-sans-first:8.98 04:51:07 INFO - PID 1687 | Values: 91.0 69.0 83.0 71.0 70.0 73.0 90.0 68.0 69.0 89.0 04:51:07 INFO - PID 1687 | 04:51:07 INFO - PID 1687 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:86.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 04:51:07 INFO - PID 1687 | Values: 86.0 86.0 87.0 85.0 88.0 86.0 87.0 86.0 86.0 86.0 04:51:07 INFO - PID 1687 | 04:51:07 INFO - PID 1687 | [#6] imaging-darkroom Cycles:10 Average:93.80 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 04:51:07 INFO - PID 1687 | Values: 94.0 93.0 93.0 94.0 94.0 94.0 94.0 95.0 94.0 93.0 04:51:07 INFO - PID 1687 | 04:51:07 INFO - PID 1687 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.50 stddev:1.20 (1.4%) stddev-sans-first:1.27 04:51:07 INFO - PID 1687 | Values: 85.0 86.0 87.0 86.0 84.0 84.0 85.0 83.0 85.0 86.0 04:51:07 INFO - PID 1687 | 04:51:07 INFO - PID 1687 | [#8] json-parse-financial Cycles:10 Average:49.10 Median:49.00 stddev:0.88 (1.8%) stddev-sans-first:0.87 04:51:07 INFO - PID 1687 | Values: 50.0 49.0 49.0 49.0 48.0 49.0 49.0 51.0 49.0 48.0 04:51:07 INFO - PID 1687 | 04:51:07 INFO - PID 1687 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:3.22 (5.6%) stddev-sans-first:3.21 04:51:07 INFO - PID 1687 | Values: 55.0 61.0 55.0 57.0 66.0 58.0 57.0 57.0 58.0 58.0 04:51:07 INFO - PID 1687 | 04:51:07 INFO - PID 1687 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:82.00 stddev:0.99 (1.2%) stddev-sans-first:1.00 04:51:07 INFO - PID 1687 | Values: 83.0 81.0 84.0 82.0 81.0 81.0 83.0 82.0 82.0 82.0 04:51:07 INFO - PID 1687 | 04:51:07 INFO - PID 1687 | [#11] stanford-crypto-ccm Cycles:10 Average:145.70 Median:142.50 stddev:15.81 (11.1%) stddev-sans-first:16.38 04:51:07 INFO - PID 1687 | Values: 136.0 138.0 136.0 140.0 137.0 157.0 145.0 148.0 186.0 134.0 04:51:07 INFO - PID 1687 | 04:51:07 INFO - PID 1687 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.70 Median:185.50 stddev:2.71 (1.5%) stddev-sans-first:2.69 04:51:07 INFO - PID 1687 | Values: 182.0 186.0 185.0 185.0 187.0 186.0 182.0 190.0 182.0 182.0 04:51:07 INFO - PID 1687 | 04:51:07 INFO - PID 1687 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:0.78 04:51:07 INFO - PID 1687 | Values: 69.0 68.0 67.0 67.0 66.0 68.0 67.0 66.0 66.0 67.0 04:51:07 INFO - PID 1687 | -------- Summary: end -------- 04:51:07 INFO - PID 1687 | 04:51:08 INFO - TEST-INFO | 1687: exit 0 04:51:08 INFO - TEST-OK | kraken | took 60359ms 04:51:08 INFO - SUITE-END | took 1181s 04:51:09 INFO - Completed test suite (00:19:41) 04:51:09 INFO - javascript benchmark 04:51:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7671.52838557839, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3486.1458942559043, 3486.4944583035463, 3489.3719130556487, 3516.4901089342047, 3548.1839176989292, 5295.735213239337, 5981.5214782817375, 6036.124761909526, 6111.266648002246, 6222.0, 6094.773429326507, 6112.969435152818, 6164.075388691698, 6179.66011869347, 6208.2239720034995, 5114.43741188469, 5333.413324534317, 5362.946370536284, 5364.356277246726, 5384.488473595002, 5445.482679145475, 5472.91790623139, 5480.835574932738, 5484.396716361217, 5547.77808887646, 5244.8688782780355, 5306.09796334624, 5325.627206095575, 5337.759800808973, 5415.810446634388, 5319.601029922733, 5320.334958130234, 5331.840044798662, 5338.466153384669, 5341.839744807662, 5221.895562088775, 5279.788808447657, 5288.444713305124, 5298.655587386807, 5302.946970530284, 6067.332593414721, 6069.2716873975405, 6071.301800292978, 6078.6048906820915, 6091.0863370494335, 6331.8733625327695, 6487.286398496161, 6553.836154096138, 6584.242812076624, 6615.17310336208, 6620.073189753439, 6710.127683401127, 6715.731370745164, 6728.730850765964, 6734.8316292092595, 5206.843794686166, 6268.153799237045, 6274.529410294246, 6294.464970477469, 6294.590851594723, 6523.988781738838, 6629.569078009914, 6640.435562977104, 6691.330866913367, 6801.18385793708, 6219.533534984895, 6314.273858506239, 6315.210598675166, 6503.479721622259, 6527.640979746159, 6386.393292637192, 6386.872262554816, 6390.201224846895, 6390.840228994312, 6410.519211059189, 6322.0516922462, 6334.904976425358, 6497.220333559909, 6582.24304205013, 6619.404253617101, 6505.349465053457, 6514.283428822826, 6519.576227545194, 6530.706118224692, 6546.050822630692, 5184.455632158569, 5238.345206849144, 5285.127953887642, 5291.894162116736, 5297.046531624267, 4689.155951928686, 4699.2481203007355, 4700.7179569225955, 4702.6473014524045, 4766.45185803637, 6155.507559395238, 6199.938000620026, 6218.81343559694, 6242.781502647385, 6252.406021427957, 6671.899921501182, 6701.396874281338, 6708.966455167791, 6725.159355080615, 6727.62998035103, 6105.664188469588, 6136.12084543884, 6233.407826256498, 6247.2815626202655, 6258.499320054385, 5761.88476230473, 5822.534197264209, 5856.385079566669, 5910.231669882888, 5924.11138329254, 6784.118064651564, 6794.286599907136, 6795.0, 6797.048413222153, 6827.385535301648, 6611.735530578723, 6628.105205797156, 6670.132882725215, 6714.899276510954, 6736.966315168393, 6499.5125365598715, 6613.603183808987, 6715.4963377747845, 6769.0, 6769.796906092825, 5495.505404513613, 6296.874062518632, 6464.0, 6529.706163222571, 6530.640814755044, 6586.506012049212, 6599.109120268702, 6634.436072933661, 6637.800865974028, 6647.867042659023, 6385.233771947396, 6439.098526206429, 6451.451626611791, 6451.516136289703, 6457.806265812033, 6190.845228869134, 6260.530460215411, 6341.682915854281, 6380.011098279774, 6403.935960640334, 6149.877002459836, 6240.126382306572, 6257.655828929453, 6299.464545513682, 6320.988641817287, 6193.071039344134, 6256.092866534418, 6271.717772700148, 6278.591891527219, 6284.088807123033, 5628.634138780966, 5893.88016276906, 6244.750209991549, 6264.966280563838, 6303.149074875017], "value": 5996.108433785908, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [794.3168874767699, 813.4549851599429, 1121.4448847820331, 1140.5836869542613, 1145.9197856150072, 36558.0, 37141.25717485649, 37262.8136859316, 37387.87836364906, 37399.439008414825, 38353.61646383535, 38711.838644840696, 38724.41913371302, 38775.0, 38802.61197388025, 6105.755769769204, 6289.339619339972, 8539.27416169628, 8652.480851148952, 8679.956600217021, 8347.791305217357, 8502.149785021511, 8534.146585341477, 8537.402381833273, 8550.572471376407, 8566.3146948244, 8621.353398495106, 8624.827503449927, 8643.567821608895, 8651.264642505395, 8555.657773689045, 8593.699220527315, 8600.354973377021, 8610.182032706884, 8615.65537378504, 8349.499030058156, 8425.536595487245, 8429.578521073983, 8429.747107586782, 8434.662613495453, 37069.0, 37321.440178397344, 37339.87980360594, 37395.25209495822, 37586.060348491235, 3623.2391197848483, 3645.5989841117457, 3666.6699997000396, 3666.944995825065, 3672.0452682302525, 30250.54624180617, 30343.24141896448, 30380.84809575938, 30402.847985760152, 30408.087757367313, 3113.0, 3148.0, 3172.159377764894, 3186.5379519969706, 3189.8245596492184, 219395.0, 290800.5459972708, 292022.0, 292255.0, 293817.5309123462, 31024.68975310263, 40437.0, 40494.79752601277, 47317.29024064642, 48393.75803120962, 50410.49589504131, 50673.74663126734, 51103.0, 51141.97716045658, 51233.0, 14021.369038393297, 14096.436142554388, 14145.151290922578, 14159.221242831538, 14163.85836141646, 9656.22750179984, 9813.950930245303, 11401.771964560663, 11413.459183010353, 11420.486078126503, 10783.406912619881, 10883.727906802393, 10887.401192934465, 10912.236143469881, 12237.816432753516, 5275.525202731773, 5355.625106242604, 5355.732213389315, 5373.167159090347, 5387.595930305164, 856.8843206167212, 1018.1549314069305, 1022.8056669232822, 1023.457567489217, 1070.8982646648556, 22654.223173090755, 24437.38906527351, 24472.265832025067, 24480.0, 24994.875230614667, 995.711243739322, 1114.4483480677118, 1116.7882847110975, 1149.6378640728144, 1157.1321508868348, 12153.756924861631, 12513.061520386007, 12515.061370397256, 12551.435185416496, 12585.811212831815, 243535.0, 247031.0, 247525.0, 248064.75967620045, 249044.0, 52369.738151309, 52747.208791867386, 52772.0, 52904.20643690348, 52961.2055819163, 1480.4818313590588, 1508.8189417269998, 1519.7416439205363, 1523.4972459088474, 1523.748581484065, 23108.653370199125, 26898.0, 27298.0, 27811.860940695165, 28730.71269287364, 36758.63241367552, 36994.26011479701, 36994.8150259247, 37003.0, 37086.0, 229403.0, 230294.0, 230315.0, 230595.0, 231033.84483077476, 33143.66856331406, 34262.0, 35256.823715881255, 35376.469352960245, 35390.292194156485, 36744.08139796527, 37630.62369376271, 38313.85058448251, 43282.0, 46128.30807537823, 28500.42999140047, 28548.0, 30268.84865575658, 31304.74781008734, 31589.0, 29783.10650680483, 30261.546076809307, 30972.845135774176, 31138.065858024296, 31524.211894701897, 36567.902962911154, 36686.816565917, 37210.06974825651, 37258.254834903695, 37328.62671373251, 30531.84734076404, 31238.0, 31668.683313166573, 31742.841285793424, 31773.84113079512, 21229.893850530647, 22232.935399540795, 22912.0, 23003.194888178834, 24354.63468048016], "value": 17025.37354026351, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.88147377997257, 420.4345155765494, 426.77167715272327, 427.79893450078464, 444.5088177563792, 19166.52083697908, 20844.478888027807, 21667.566648667016, 21764.238251661176, 21856.125754969784, 21318.040688169032, 21911.67132493014, 22065.558688826215, 22167.78077205753, 22395.888020559876, 5961.195238642782, 6289.0252010938375, 6294.2761582417925, 6305.747770089191, 6305.905411418832, 5916.408359164071, 6141.692915354237, 6171.290301615327, 6215.782447614334, 6221.813345599639, 6010.36891126432, 6167.383261673819, 6186.0, 6188.226471691039, 6193.318734939153, 6037.849053773647, 6171.6297022178815, 6173.69131543421, 6184.690765461709, 6185.0, 5374.328208973879, 5483.561315094783, 5487.506124448819, 5497.890042199134, 5550.389457159709, 27507.58738618922, 27564.86217568899, 27690.030848920393, 28095.15714528547, 28423.85788071067, 2092.7384076990375, 2161.275972549198, 2164.3290579920117, 2167.5556510915226, 2170.934871953828, 17469.301227950866, 17626.823731762648, 17678.646427071515, 18210.90894545532, 18422.90788546049, 1808.4755420927916, 1836.6602178596868, 2120.257909731597, 2152.182170775111, 2152.2682288022147, 149778.0, 150467.0, 151760.0, 152288.0, 154523.0, 10306.33008854422, 11398.430078496041, 11960.222585531912, 12022.939885300517, 12196.756064878653, 15992.36030558788, 15997.960387526333, 16001.359945602278, 16009.679806403807, 16040.117793521234, 7187.496875218684, 7381.8154546136775, 8465.153484651608, 8800.823983520293, 8952.507612081397, 8355.206255405727, 8362.498250105013, 8373.288270496954, 8550.82898342042, 8559.101294364002, 7556.735514256975, 7674.774315448569, 7722.150563438017, 7746.38028957682, 7749.496282741717, 1723.7069698151345, 2049.549099198174, 2057.8289904151266, 2066.5660211355485, 2190.1677362602427, 951.6098399656108, 957.3585697582637, 960.7598100474881, 989.7179303898355, 993.9105480506645, 20998.265060722802, 21360.93195340227, 21382.893085534783, 21559.461013474476, 21650.783492165192, 896.4486840592988, 984.542187882638, 1001.689476262361, 1011.3426272922659, 1023.0970395065173, 10480.056794888344, 10860.72848178786, 10935.507902144423, 10938.179636527293, 10943.507542160622, 595705.0, 595812.0, 599461.008084879, 610812.0, 614699.0, 95540.0, 102421.4636780449, 118640.0, 118834.0, 137566.0, 1083.1876092930302, 1157.9826302605468, 1247.8190662354089, 1279.9744005119846, 1295.6242689620094, 19013.71479427782, 20958.056887440405, 20996.790032100096, 22879.856007199905, 22911.656325154803, 56542.80129381299, 57425.0, 57480.0, 58037.42382506839, 58457.0, 81727.0, 82038.58980705058, 82408.76386854082, 82436.17563824524, 83087.75368369359, 12819.871801281868, 12947.158434701714, 13066.869331306565, 13475.865241347461, 13476.460941562227, 14099.295035248402, 14341.92829035848, 14432.639184020483, 14465.540858054366, 14608.853911461174, 11616.186866919235, 11859.822102668295, 12068.51725930988, 12090.214136081127, 12103.878961210276, 11145.55417783312, 11289.491972861077, 11534.654950064387, 11677.941610291895, 11814.645560633195, 11541.480633371351, 11967.880321196677, 12124.636260912186, 12282.877171228174, 12325.260484370967, 12095.637130886087, 13117.147385419918, 13190.538331158363, 13197.294554616088, 13210.0, 11764.352960586908, 11770.82343764827, 12032.879671203176, 12045.457954391899, 12150.088743344108], "value": 10639.016610791663, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1279.1877158004668, 1403.7262733766913, 1467.8972471926963, 1491.358715752226, 1502.5867886331264, 11202.831957520644, 11710.180287379886, 11710.882891171106, 11715.941420292907, 11718.882811171896, 9287.907120928789, 11514.309141451498, 11833.467493962771, 11850.288982661046, 11873.643790686294, 2089.4045197118826, 2180.767866155617, 2501.6872890888685, 2545.770880620744, 2548.3501707064675, 2009.9698504522444, 2380.5476959377747, 2531.999860055277, 2534.3664083979006, 2537.2768760903145, 1735.0, 2189.8467107302495, 2192.024549075662, 2192.495725983025, 2194.1552502286654, 2155.6012137754565, 2429.963550546743, 2524.8106392020673, 2524.962125568118, 2526.84838909666, 2500.3374105861963, 2505.5740524110943, 2528.8735563221767, 2542.7075886272946, 2542.8474291542566, 11856.466459009365, 11986.280823150639, 11991.64025079249, 12000.339981301026, 12029.0, 6466.385693359123, 6712.0, 6722.226943901416, 6727.562708423937, 6729.293424190488, 3538.6638269364626, 4015.2371049500503, 4251.829926802955, 4334.6592839866435, 4335.891602709926, 1212.8847759462838, 1229.5450683247257, 1271.7456508698297, 1276.9170003949807, 1278.7826069568196, 16462.341506339733, 16528.83471165297, 16546.66906661872, 16576.917115414468, 16587.83412165887, 4389.736615803062, 5328.760205790749, 5518.806841760519, 5526.447355264522, 5581.748821303051, 12357.0, 12381.690457738448, 12397.814032789516, 12407.193532420364, 12408.19346742477, 6498.252700939453, 6509.381608747161, 6510.641914694643, 6514.022896565459, 6516.022596610546, 5162.97418512905, 5806.809604031164, 6077.179580756541, 6113.724882380304, 6201.81394558164, 4306.80619372129, 4393.340998850134, 4424.6902716810155, 4456.844010459618, 4458.331250312479, 1257.2770656872335, 1269.5873841001712, 1275.8213850061, 1293.0948336164722, 1300.6228193823686, 713.3579778199662, 770.8419773946327, 791.1258059843905, 796.283344989514, 799.4523751230425, 6642.615873523451, 6717.0, 6864.450843932474, 6893.896591551131, 6983.336583024706, 899.9010108888017, 903.408267584733, 918.2883265469181, 939.5067589515559, 964.5514835601479, 4049.635532802062, 4104.18310970794, 4150.730202536825, 4333.58830911063, 4352.760598167068, 14253.144811311355, 14782.704345913236, 14823.332950017275, 14824.3329050193, 14828.555143345717, 14517.637059073397, 14570.19863907474, 14888.925555372154, 14914.776278355834, 14942.626434339229, 8139.348852091818, 8272.420930534805, 8317.584120793936, 8321.292690121407, 8327.50034997902, 5537.944620553743, 6063.636181829104, 6523.086767852409, 6529.661419409104, 6785.389314961677, 10264.384136951807, 12605.87394126047, 13217.074804763573, 13222.867771322548, 13259.0, 12251.38743062861, 13592.45630174782, 13596.66008349799, 13615.115017523829, 13814.723705526034, 9130.269578433843, 9503.144716975505, 9517.714468565953, 9520.571574279313, 9534.95232523833, 10252.794944100928, 10558.8416173759, 10654.360738355723, 10687.732806679895, 10724.195685323475, 9116.0, 9159.450432974043, 9171.35800493959, 9184.49485278316, 9196.218321442751, 8823.602937867683, 8879.600417981077, 8898.154675305836, 8901.154390332907, 8949.0, 7889.921100788919, 8032.196780321921, 8032.959835200787, 8042.276195142465, 8047.919520804717, 5905.379935106752, 5925.229720136527, 6058.363871793398, 6111.266648002268, 6144.078388241799, 5541.916871246854, 5735.369109398046, 6093.421124993119, 6112.969435152796, 6314.0], "value": 5301.094549811153, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.87654012445955, 382.48364707644663, 389.3750530398712, 389.5092183848351, 392.8762439831453, 4691.061787642472, 4721.527847215277, 5686.147077938306, 5738.3974682658345, 5756.165356023374, 5491.28613280273, 5604.898163188805, 5613.46672066154, 5624.943750562493, 5667.433256674331, 4149.398337241113, 4274.465691788527, 4313.762743049131, 4332.826686932519, 4364.236258654731, 3710.499082623838, 4194.266003449399, 4247.787610619472, 4252.596003379689, 4266.893327666818, 3505.7020153287003, 3551.147724546116, 4180.811863466151, 4210.063370849413, 4244.660427165834, 3700.5374328208973, 4228.9154216915485, 4244.745315281062, 4248.150369926012, 4271.9359209611885, 3025.243689077731, 3089.675584063686, 3503.6671516206175, 3679.6504332088407, 3697.3563901810335, 5539.362973258087, 5560.49866536033, 5568.805091821807, 5595.63628364155, 5604.719764011783, 4712.939588592573, 4999.7750101245165, 5006.824761133379, 5010.323606313137, 5013.398392192924, 4556.0, 5310.9734451327495, 6071.271447426293, 6105.267367915834, 6153.600015998991, 3340.1816554943953, 3581.94627080594, 4113.115680128757, 4130.731502452331, 4136.110736191733, 6185.175373264853, 6215.96892015537, 6382.68086595673, 6385.936140638627, 6509.0, 3535.876244331436, 3575.606683264839, 3714.6285371463177, 4017.658499027557, 4227.7040607157205, 4293.613574778223, 4295.0, 4297.247981603207, 4305.16049370376, 4324.091940692427, 4740.5733483986605, 4834.903301933941, 4983.377077865267, 5011.747063234191, 5043.84868453947, 5039.807683657621, 5662.85842853932, 5975.671338076448, 6224.782132625336, 6231.345708700612, 1208.4984731336572, 1456.155429850684, 1462.4515806572535, 1464.633841539615, 1468.7062587482546, 891.140049851896, 931.4225180388203, 962.0379620379621, 985.4235272365746, 994.4182653147844, 4682.74244916526, 4928.950710492849, 5829.0, 5863.208466857005, 5893.882122357529, 5644.774209031675, 6403.911335073049, 6405.615663060231, 6419.878853250641, 6435.967820160869, 5324.7753016806355, 5571.8269874748885, 5749.3778919280585, 5796.188533605298, 5800.0, 2794.5389010813396, 2918.562215667667, 2926.5024945759274, 3034.9393012139635, 3345.0633822529244, 5284.445133261029, 5641.633293835887, 6198.566100372931, 6254.937450625435, 6485.319041500669, 5688.720037991418, 6455.741770329134, 6504.577202481918, 6515.218173819172, 6523.249131749263, 5309.354100228941, 6518.641474718841, 6526.706298216592, 6531.0, 6533.18335208099, 5505.449455054622, 5530.668159910419, 5672.376038635829, 6327.272363678052, 6375.458086062551, 6325.525585581192, 6329.620222786648, 6347.904781428375, 6372.490200784019, 6375.0, 6114.602550834182, 6447.742090316335, 6485.967570162119, 6527.412532872065, 6545.934540654533, 4140.585941405835, 4578.633709303314, 4632.328312394617, 4642.187617166915, 4643.976780116078, 4883.0, 5381.273528073816, 6196.0, 6337.144485494584, 6405.843296146647, 4507.887302817456, 5911.467967882739, 6054.218221598275, 6228.937710622836, 6254.718537665907, 4784.976075119741, 5296.735163241746, 5458.372287186866, 6204.790065937099, 6253.49860055963, 4859.659823812441, 5310.044192045469, 5782.653040817564, 6093.116498107838, 6112.0, 5174.663646862942, 6207.379262073757, 6227.50179985591, 6280.497560195082, 6307.0, 5907.32065812437, 6019.404857712622, 6088.665123418255, 6105.931461994044, 6222.81331560054], "value": 4410.985761663916, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.0869890889119, 731.2869951796998, 858.7037472072133, 869.2524428991071, 880.0759202837022, 13500.257485838274, 18075.72886406705, 18822.52943676409, 18825.529361765963, 18871.905640471814, 17366.0, 17683.73474397885, 17854.196561154746, 17862.732059019094, 17889.552761180978, 968.1770495079179, 1003.523326419952, 1005.7385079879248, 1007.0986467111967, 1007.8588997540351, 673.636236432326, 690.3924546399187, 691.4710246661308, 693.2616763147232, 694.1150033707039, 987.2743533502905, 1017.0795430135702, 1025.7743296474764, 1026.1124127629585, 1026.9743256418612, 1018.9592416303376, 1019.2457581389792, 1021.4688362051729, 1024.933379330341, 1026.3687831983352, 755.0147058089192, 756.0134025097246, 756.3646536908968, 758.6206896551724, 759.3166150464571, 16847.66304673912, 16986.66026679472, 17165.05592192429, 17313.480595582027, 17602.647947041114, 17224.569385765455, 17239.138043097795, 17411.65176696472, 17582.824171758373, 17672.293108275782, 13895.861041389559, 14164.150150990974, 14175.503857364944, 14392.992490525667, 14412.063215890934, 3404.4042292598697, 3433.5536380270655, 3435.587729472479, 3435.656434356569, 3436.347094052122, 118363.0, 119817.0, 120760.0, 121777.0, 122084.38957805243, 10855.891441085489, 12070.818937715942, 12412.937935310265, 12413.06901982355, 13506.527271545448, 20103.597928041356, 24849.39683745883, 25141.622875656878, 25466.74533254681, 25541.97832086733, 7521.811954701177, 7532.811679708051, 7610.0, 7615.657295421719, 7617.085949685962, 3064.586280852101, 3842.3852183650483, 3844.884653460401, 3850.268448994682, 3854.3062248794927, 4307.547707490731, 4403.735775853395, 4413.16149931512, 4424.11517696462, 4426.0, 867.5618812499773, 884.5621417398429, 887.0863011098579, 888.9066648001996, 890.8485557455248, 651.4853265919965, 656.74715234635, 668.4418510543751, 681.7477533312706, 682.1916029505053, 11037.337759734442, 11447.713807154722, 11899.226550274205, 11908.642740717793, 12092.758144837055, 648.8994205898093, 659.3571268013649, 663.8008597420754, 663.8771827211981, 674.1573033707865, 5298.231756395301, 5310.389305229871, 5445.9727701362035, 5520.66875987442, 5576.247206627135, 99924.0, 100034.0, 100534.0, 106972.46513767538, 108844.58486642099, 91432.0, 92611.53694231485, 92620.05349598672, 93928.0, 95990.52004739932, 60135.0, 82860.58569707113, 84449.0, 84774.57612711897, 85657.57171214104, 10491.790164196826, 10784.029437350677, 10990.780184396108, 11093.722656933642, 11134.27627204229, 33253.33493330168, 41342.793286033375, 41373.586264136975, 42657.5734242666, 42776.5722342785, 54178.72910635579, 54228.72885635705, 55078.0, 55348.44651553433, 56247.71876140593, 12761.042921780718, 14462.85537144615, 14697.0, 14728.55814325572, 14738.63153421173, 15442.0734755915, 15953.361865525714, 15974.680506389575, 15986.280617372478, 16002.439914602934, 14245.64385890361, 14472.638184045483, 14500.709985800015, 14604.488842890873, 14702.55892323232, 14464.421423142956, 14594.562163135122, 14653.413863445769, 14746.967712260039, 14805.259737013323, 14069.0, 14261.358238879482, 14365.281735913371, 14409.78385324242, 14591.854081459474, 10700.518476668412, 10897.455127243447, 10962.506687198937, 11033.834492482458, 11073.335599864035, 11668.94165529167, 11791.823122653339, 11813.350265735467, 11895.702607434883, 12053.879461205275], "value": 8025.811945339488, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1427.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 109.0, 111.0, 111.0, 111.0, 111.0, 111.0, 118.0, 164.0, 153.0], "value": 121.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 111.0, 109.0, 149.0, 111.0, 112.0, 123.0, 140.0, 150.0, 110.0], "value": 125.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 185.0, 185.0, 187.0, 187.0, 187.0, 182.0, 182.0, 186.0, 187.0], "value": 185.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 61.0, 57.0, 87.0, 61.0, 59.0, 60.0, 59.0, 83.0, 57.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 69.0, 83.0, 71.0, 70.0, 73.0, 90.0, 68.0, 69.0, 89.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 87.0, 85.0, 88.0, 86.0, 87.0, 86.0, 86.0, 86.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 87.0, 86.0, 84.0, 84.0, 85.0, 83.0, 85.0, 86.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 49.0, 49.0, 48.0, 49.0, 49.0, 51.0, 49.0, 48.0], "value": 49.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 61.0, 55.0, 57.0, 66.0, 58.0, 57.0, 57.0, 58.0, 58.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 84.0, 82.0, 81.0, 81.0, 83.0, 82.0, 82.0, 82.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 138.0, 136.0, 140.0, 137.0, 157.0, 145.0, 148.0, 186.0, 134.0], "value": 145.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 186.0, 185.0, 185.0, 187.0, 186.0, 182.0, 190.0, 182.0, 182.0], "value": 184.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 67.0, 67.0, 66.0, 68.0, 67.0, 66.0, 66.0, 67.0], "value": 67.1, "unit": "score"}]}]} 04:51:09 INFO - Return code: 0 04:51:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:51:09 ERROR - # TBPL SUCCESS # 04:51:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:51:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:51:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:51:09 INFO - 2017-04-17 04:51:09.178 screenresolution[1692:12875] starting screenresolution argv=screenresolution get 04:51:09 INFO - 2017-04-17 04:51:09.181 screenresolution[1692:12875] Display 0: 1600x1200x32@60 04:51:09 INFO - 2017-04-17 04:51:09.187 screenresolution[1693:12878] starting screenresolution argv=screenresolution list 04:51:09 INFO - Available Modes on Display 0 04:51:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:51:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:51:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:51:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:51:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:51:09 INFO - Intel Iris: 04:51:09 INFO - Chipset Model: Intel Iris 04:51:09 INFO - Type: GPU 04:51:09 INFO - Bus: Built-In 04:51:09 INFO - VRAM (Dynamic, Max): 1536 MB 04:51:09 INFO - Vendor: Intel (0x8086) 04:51:09 INFO - Device ID: 0x0a2e 04:51:09 INFO - Revision ID: 0x0009 04:51:09 INFO - Displays: 04:51:09 INFO - Display: 04:51:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:51:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:51:09 INFO - Display Serial Number: 1600x1200 60 04:51:09 INFO - Main Display: Yes 04:51:09 INFO - Mirror: Off 04:51:09 INFO - Online: Yes 04:51:09 INFO - Rotation: Supported 04:51:09 INFO - Return code: 0 04:51:09 INFO - Running post-action listener: _resource_record_post_action 04:51:09 INFO - [mozharness: 2017-04-17 11:51:09.422299Z] Finished run-tests step (success) 04:51:09 INFO - Running post-run listener: _resource_record_post_run 04:51:09 INFO - Total resource usage - Wall time: 1202s; CPU: 53.0%; Read bytes: 31890944; Write bytes: 516056576; Read time: 321; Write time: 1643 04:51:09 INFO - TinderboxPrint: CPU usage
53.3% 04:51:09 INFO - TinderboxPrint: I/O read bytes / time
31,890,944 / 321 04:51:09 INFO - TinderboxPrint: I/O write bytes / time
516,056,576 / 1,643 04:51:09 INFO - TinderboxPrint: CPU idle
2,244.2 (46.7%) 04:51:09 INFO - TinderboxPrint: CPU system
955.9 (19.9%) 04:51:09 INFO - TinderboxPrint: CPU user
1,609.5 (33.5%) 04:51:09 INFO - TinderboxPrint: Swap in / out
235,991,040 / 0 04:51:09 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207923712; Write bytes: 204961280; Read time: 16369; Write time: 432 04:51:09 INFO - run-tests - Wall time: 1183s; CPU: 53.0%; Read bytes: 28995072; Write bytes: 303898624; Read time: 290; Write time: 1182 04:51:09 INFO - Running post-run listener: _upload_blobber_files 04:51:09 INFO - Blob upload gear active. 04:51:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:51:09 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:51:09 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:51:09 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:51:10 INFO - (blobuploader) - INFO - Open directory for files ... 04:51:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:51:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:51:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:12 INFO - (blobuploader) - INFO - Done attempting. 04:51:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:51:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:51:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:14 INFO - (blobuploader) - INFO - Done attempting. 04:51:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:51:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:51:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:16 INFO - (blobuploader) - INFO - Done attempting. 04:51:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:51:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:51:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:21 INFO - (blobuploader) - INFO - Done attempting. 04:51:21 INFO - (blobuploader) - INFO - Iteration through files over. 04:51:21 INFO - Return code: 0 04:51:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:51:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:51:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07440d868a06c70efa2824681addaeb2b3f09127c5466b012e0b934510355b4106c4386a588f4b2293e8cd803c20bf1f1d1e0d593db3854b41910c15717e0bfd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ec01c639aee0ec64f8198161d16fac52b8ac9fbd43ae47745bfca1a0efd8a73e503cd90d703e368ab93b9fb90ecd85f1ff7104cfe8a93a8b6591c551d157543", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5507678ec533d91653bf07ca24baa7d6ba2c804ea0be85ee2be1ac00c2d7ddfa5d28bcbf3945b6d85e3a08e9f5b6dd9d809d929a065c586ad980ce596bc02d1d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be7b101919f3d3eb590afc91203188135e4fbc530a6cccaa0692049f657a51f281fd694a76f19b01ca9a8b28fe0b1e5188374e151ddc6653e15f0db2c21afe8e"} 04:51:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:51:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:51:21 INFO - Contents: 04:51:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07440d868a06c70efa2824681addaeb2b3f09127c5466b012e0b934510355b4106c4386a588f4b2293e8cd803c20bf1f1d1e0d593db3854b41910c15717e0bfd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ec01c639aee0ec64f8198161d16fac52b8ac9fbd43ae47745bfca1a0efd8a73e503cd90d703e368ab93b9fb90ecd85f1ff7104cfe8a93a8b6591c551d157543", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5507678ec533d91653bf07ca24baa7d6ba2c804ea0be85ee2be1ac00c2d7ddfa5d28bcbf3945b6d85e3a08e9f5b6dd9d809d929a065c586ad980ce596bc02d1d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be7b101919f3d3eb590afc91203188135e4fbc530a6cccaa0692049f657a51f281fd694a76f19b01ca9a8b28fe0b1e5188374e151ddc6653e15f0db2c21afe8e"} 04:51:21 INFO - Running post-run listener: copy_logs_to_upload_dir 04:51:21 INFO - Copying logs to upload dir... 04:51:21 INFO - mkdir: /builds/slave/test/build/upload/logs 04:51:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1290.988895 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2017-04-17 04:51:21.166358) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-17 04:51:21.171411) ========= 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.syg3UALygH/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.nbgavzHhSS/Listeners TMPDIR=/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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/07440d868a06c70efa2824681addaeb2b3f09127c5466b012e0b934510355b4106c4386a588f4b2293e8cd803c20bf1f1d1e0d593db3854b41910c15717e0bfd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ec01c639aee0ec64f8198161d16fac52b8ac9fbd43ae47745bfca1a0efd8a73e503cd90d703e368ab93b9fb90ecd85f1ff7104cfe8a93a8b6591c551d157543", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5507678ec533d91653bf07ca24baa7d6ba2c804ea0be85ee2be1ac00c2d7ddfa5d28bcbf3945b6d85e3a08e9f5b6dd9d809d929a065c586ad980ce596bc02d1d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be7b101919f3d3eb590afc91203188135e4fbc530a6cccaa0692049f657a51f281fd694a76f19b01ca9a8b28fe0b1e5188374e151ddc6653e15f0db2c21afe8e"} build_url:https://queue.taskcluster.net/v1/task/Nf1hrFrlQW6SHW1SOPBElQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011141 build_url: 'https://queue.taskcluster.net/v1/task/Nf1hrFrlQW6SHW1SOPBElQ/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/07440d868a06c70efa2824681addaeb2b3f09127c5466b012e0b934510355b4106c4386a588f4b2293e8cd803c20bf1f1d1e0d593db3854b41910c15717e0bfd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ec01c639aee0ec64f8198161d16fac52b8ac9fbd43ae47745bfca1a0efd8a73e503cd90d703e368ab93b9fb90ecd85f1ff7104cfe8a93a8b6591c551d157543", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5507678ec533d91653bf07ca24baa7d6ba2c804ea0be85ee2be1ac00c2d7ddfa5d28bcbf3945b6d85e3a08e9f5b6dd9d809d929a065c586ad980ce596bc02d1d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be7b101919f3d3eb590afc91203188135e4fbc530a6cccaa0692049f657a51f281fd694a76f19b01ca9a8b28fe0b1e5188374e151ddc6653e15f0db2c21afe8e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-17 04:51:21.213699) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 04:51:21.214051) ========= 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.syg3UALygH/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.nbgavzHhSS/Listeners TMPDIR=/var/folders/sx/77r6qnn55xj86zkv7mbvc7k800000w/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.005029 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 04:51:21.262618) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-17 04:51:21.265974) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-17 04:51:21.266311) ========= ========= Total master_lag: 0.20 =========