builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1480568636.23 results: success (0) buildid: 20161130182143 builduid: c68e0c4de11546438b1a94bcadb16004 revision: 63121d897767457eaae42cfe5371268274f145c8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 21:03:56.233606) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 21:03:56.234045) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 21:03:56.234336) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 21:03:56.251783) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 21:03:56.252039) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1480566404.276316-1892045505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-30 21:03:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 59.1M=0s 2016-11-30 21:03:57 (59.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.135835 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 21:03:56.401514) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 21:03:56.401817) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1480566404.276316-1892045505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017294 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 21:03:56.450789) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 21:03:56.451108) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 63121d897767457eaae42cfe5371268274f145c8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 63121d897767457eaae42cfe5371268274f145c8 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1480566404.276316-1892045505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-30 21:03:57,798 truncating revision to first 12 chars 2016-11-30 21:03:57,798 Setting DEBUG logging. 2016-11-30 21:03:57,798 attempt 1/10 2016-11-30 21:03:57,798 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/63121d897767?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-30 21:03:58,094 unpacking tar archive at: mozilla-beta-63121d897767/testing/mozharness/ program finished with exit code 0 elapsedTime=0.647003 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 21:03:57.111280) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 21:03:57.111587) ========= script_repo_revision: 63121d897767457eaae42cfe5371268274f145c8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 21:03:57.111961) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 21:03:57.112222) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 21:03:57.127870) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-11-30 21:03:57.128150) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1480566404.276316-1892045505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:03:58 INFO - MultiFileLogger online at 20161130 21:03:58 in /builds/slave/test 21:03:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 21:03:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:03:58 INFO - {'append_to_log': False, 21:03:58 INFO - 'base_work_dir': '/builds/slave/test', 21:03:58 INFO - 'blob_upload_branch': 'Mozilla-Beta', 21:03:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:03:58 INFO - 'branch': 'Mozilla-Beta', 21:03:58 INFO - 'buildbot_json_path': 'buildprops.json', 21:03:58 INFO - 'config_files': ('talos/linux_config.py',), 21:03:58 INFO - 'default_actions': ('clobber', 21:03:58 INFO - 'read-buildbot-config', 21:03:58 INFO - 'download-and-extract', 21:03:58 INFO - 'populate-webroot', 21:03:58 INFO - 'create-virtualenv', 21:03:58 INFO - 'install', 21:03:58 INFO - 'run-tests'), 21:03:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:03:58 INFO - 'download_minidump_stackwalk': True, 21:03:58 INFO - 'download_symbols': 'ondemand', 21:03:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:03:58 INFO - 'tooltool.py': '/tools/tooltool.py', 21:03:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:03:58 INFO - '/tools/misc-python/virtualenv.py')}, 21:03:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:03:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:03:58 INFO - 'installer_path': 'installer.exe', 21:03:58 INFO - 'log_level': 'info', 21:03:58 INFO - 'log_name': 'talos', 21:03:58 INFO - 'log_to_console': True, 21:03:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:03:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:03:58 INFO - 'opt_config_files': (), 21:03:58 INFO - 'pip_index': False, 21:03:58 INFO - 'sps_profile': False, 21:03:58 INFO - 'sps_profile_interval': 0, 21:03:58 INFO - 'suite': 'dromaeojs', 21:03:58 INFO - 'system_bits': '32', 21:03:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:03:58 INFO - 'title': 'talos-linux64-ix-056', 21:03:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:03:58 INFO - 'use_talos_json': True, 21:03:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:03:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:03:58 INFO - 'work_dir': 'build'} 21:03:58 INFO - [mozharness: 2016-12-01 05:03:58.578126Z] Running clobber step. 21:03:58 INFO - Running pre-action listener: _resource_record_pre_action 21:03:58 INFO - Running main action method: clobber 21:03:58 INFO - rmtree: /builds/slave/test/build 21:03:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:03:59 INFO - Running post-action listener: _resource_record_post_action 21:03:59 INFO - [mozharness: 2016-12-01 05:03:59.040188Z] Finished clobber step (success) 21:03:59 INFO - [mozharness: 2016-12-01 05:03:59.040289Z] Running read-buildbot-config step. 21:03:59 INFO - Running pre-action listener: _resource_record_pre_action 21:03:59 INFO - Running main action method: read_buildbot_config 21:03:59 INFO - Using buildbot properties: 21:03:59 INFO - { 21:03:59 INFO - "project": "", 21:03:59 INFO - "product": "firefox", 21:03:59 INFO - "script_repo_revision": "production", 21:03:59 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 21:03:59 INFO - "repository": "", 21:03:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 21:03:59 INFO - "buildid": "20161130182143", 21:03:59 INFO - "pgo_build": "True", 21:03:59 INFO - "basedir": "/builds/slave/test", 21:03:59 INFO - "buildnumber": 19, 21:03:59 INFO - "slavename": "talos-linux64-ix-056", 21:03:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:03:59 INFO - "platform": "ubuntu64_hw", 21:03:59 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 21:03:59 INFO - "branch": "mozilla-beta", 21:03:59 INFO - "repo_path": "releases/mozilla-beta", 21:03:59 INFO - "revision": "63121d897767457eaae42cfe5371268274f145c8", 21:03:59 INFO - "stage_platform": "linux64-pgo", 21:03:59 INFO - "builduid": "c68e0c4de11546438b1a94bcadb16004", 21:03:59 INFO - "slavebuilddir": "test" 21:03:59 INFO - } 21:03:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/KHWzPn8aRuWqCFdxt2NrPQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2. 21:03:59 INFO - Running post-action listener: _resource_record_post_action 21:03:59 INFO - [mozharness: 2016-12-01 05:03:59.042734Z] Finished read-buildbot-config step (success) 21:03:59 INFO - [mozharness: 2016-12-01 05:03:59.042823Z] Running download-and-extract step. 21:03:59 INFO - Running pre-action listener: _resource_record_pre_action 21:03:59 INFO - Running main action method: download_and_extract 21:03:59 INFO - mkdir: /builds/slave/test/build/tests 21:03:59 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')]} 21:03:59 INFO - trying https://queue.taskcluster.net/v1/task/KHWzPn8aRuWqCFdxt2NrPQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 21:03:59 INFO - Downloading https://queue.taskcluster.net/v1/task/KHWzPn8aRuWqCFdxt2NrPQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 21:03:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KHWzPn8aRuWqCFdxt2NrPQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:03:59 INFO - Downloaded 1327 bytes. 21:03:59 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 21:03:59 INFO - Using the following test package requirements: 21:03:59 INFO - {u'common': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 21:03:59 INFO - u'cppunittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:03:59 INFO - u'firefox-51.0.en-US.linux-x86_64.cppunittest.tests.zip'], 21:03:59 INFO - u'gtest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:03:59 INFO - u'firefox-51.0.en-US.linux-x86_64.gtest.tests.zip'], 21:03:59 INFO - u'jittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:03:59 INFO - u'jsshell-linux-x86_64.zip'], 21:03:59 INFO - u'mochitest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:03:59 INFO - u'firefox-51.0.en-US.linux-x86_64.mochitest.tests.zip'], 21:03:59 INFO - u'mozbase': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 21:03:59 INFO - u'reftest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:03:59 INFO - u'firefox-51.0.en-US.linux-x86_64.reftest.tests.zip'], 21:03:59 INFO - u'talos': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:03:59 INFO - u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'], 21:03:59 INFO - u'web-platform': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:03:59 INFO - u'firefox-51.0.en-US.linux-x86_64.web-platform.tests.zip'], 21:03:59 INFO - u'xpcshell': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 21:03:59 INFO - u'firefox-51.0.en-US.linux-x86_64.xpcshell.tests.zip']} 21:03:59 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:03:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KHWzPn8aRuWqCFdxt2NrPQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 21:03:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KHWzPn8aRuWqCFdxt2NrPQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:03:59 INFO - Fetch https://queue.taskcluster.net/v1/task/KHWzPn8aRuWqCFdxt2NrPQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 21:04:00 INFO - Expected file size: 21963922 21:04:04 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:04:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KHWzPn8aRuWqCFdxt2NrPQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 21:04:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KHWzPn8aRuWqCFdxt2NrPQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:04:04 INFO - Fetch https://queue.taskcluster.net/v1/task/KHWzPn8aRuWqCFdxt2NrPQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 21:04:04 INFO - Expected file size: 21963922 21:04:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KHWzPn8aRuWqCFdxt2NrPQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip 21:04:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KHWzPn8aRuWqCFdxt2NrPQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:04:09 INFO - Fetch https://queue.taskcluster.net/v1/task/KHWzPn8aRuWqCFdxt2NrPQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip into memory 21:04:10 INFO - Expected file size: 14414089 21:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:10 INFO - trying https://queue.taskcluster.net/v1/task/KHWzPn8aRuWqCFdxt2NrPQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 21:04:10 INFO - Downloading https://queue.taskcluster.net/v1/task/KHWzPn8aRuWqCFdxt2NrPQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 21:04:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KHWzPn8aRuWqCFdxt2NrPQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:04:11 INFO - Downloaded 56962717 bytes. 21:04:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KHWzPn8aRuWqCFdxt2NrPQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 21:04:11 INFO - mkdir: /builds/slave/test/properties 21:04:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:04:11 INFO - Writing to file /builds/slave/test/properties/build_url 21:04:11 INFO - Contents: 21:04:11 INFO - build_url:https://queue.taskcluster.net/v1/task/KHWzPn8aRuWqCFdxt2NrPQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 21:04:12 INFO - Running post-action listener: _resource_record_post_action 21:04:12 INFO - Running post-action listener: set_extra_try_arguments 21:04:12 INFO - [mozharness: 2016-12-01 05:04:12.465533Z] Finished download-and-extract step (success) 21:04:12 INFO - [mozharness: 2016-12-01 05:04:12.465832Z] Running populate-webroot step. 21:04:12 INFO - Running pre-action listener: _resource_record_pre_action 21:04:12 INFO - Running main action method: populate_webroot 21:04:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:04:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:04:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:04:12 INFO - '--tppagecycles', 21:04:12 INFO - '7'], 21:04:12 INFO - 'tests': ['tsvgm']}}, 21:04:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:04:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:04:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:04:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:04:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:04:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:04:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:12 INFO - 'talos_options': ['--disable-e10s'], 21:04:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:04:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:04:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:12 INFO - 'talos_options': ['--disable-e10s'], 21:04:12 INFO - 'tests': ['damp', 'tps']}, 21:04:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:12 INFO - 'tests': ['damp', 'tps']}, 21:04:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:04:12 INFO - 'tests': ['dromaeo_dom']}, 21:04:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:04:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:04:12 INFO - 'tests': ['basic_compositor_video']}, 21:04:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:04:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:04:12 INFO - 'tests': ['a11yr', 21:04:12 INFO - 'ts_paint', 21:04:12 INFO - 'tpaint', 21:04:12 INFO - 'sessionrestore', 21:04:12 INFO - 'sessionrestore_no_auto_restore', 21:04:12 INFO - 'tabpaint']}, 21:04:12 INFO - 'other-e10s': {'tests': ['a11yr', 21:04:12 INFO - 'ts_paint', 21:04:12 INFO - 'tpaint', 21:04:12 INFO - 'sessionrestore', 21:04:12 INFO - 'sessionrestore_no_auto_restore', 21:04:12 INFO - 'tabpaint']}, 21:04:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:04:12 INFO - 'ts_paint', 21:04:12 INFO - 'tpaint', 21:04:12 INFO - 'sessionrestore', 21:04:12 INFO - 'sessionrestore_no_auto_restore', 21:04:12 INFO - 'tabpaint']}, 21:04:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:04:12 INFO - 'ts_paint', 21:04:12 INFO - 'tpaint', 21:04:12 INFO - 'sessionrestore', 21:04:12 INFO - 'sessionrestore_no_auto_restore', 21:04:12 INFO - 'tabpaint']}, 21:04:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:04:12 INFO - 'tests': ['a11yr', 21:04:12 INFO - 'ts_paint', 21:04:12 INFO - 'tpaint', 21:04:12 INFO - 'sessionrestore', 21:04:12 INFO - 'sessionrestore_no_auto_restore', 21:04:12 INFO - 'tabpaint']}, 21:04:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:04:12 INFO - 'tests': ['a11yr', 21:04:12 INFO - 'ts_paint', 21:04:12 INFO - 'tpaint', 21:04:12 INFO - 'sessionrestore', 21:04:12 INFO - 'sessionrestore_no_auto_restore', 21:04:12 INFO - 'tabpaint']}, 21:04:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:04:12 INFO - 'tests': ['tsvgx', 21:04:12 INFO - 'tsvgr_opacity', 21:04:12 INFO - 'tart', 21:04:12 INFO - 'tscrollx', 21:04:12 INFO - 'cart']}, 21:04:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:04:12 INFO - 'tsvgr_opacity', 21:04:12 INFO - 'tart', 21:04:12 INFO - 'tscrollx', 21:04:12 INFO - 'cart']}, 21:04:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:12 INFO - 'talos_options': ['--disable-e10s'], 21:04:12 INFO - 'tests': ['tp5o']}, 21:04:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:12 INFO - 'tests': ['tp5o']}, 21:04:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:12 INFO - 'talos_options': ['--disable-e10s', 21:04:12 INFO - '--xperf_path', 21:04:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:04:12 INFO - 'tests': ['tp5n']}, 21:04:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:04:12 INFO - 'talos_options': ['--xperf_path', 21:04:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:04:12 INFO - 'tests': ['tp5n']}}, 21:04:12 INFO - 'talos.zip': {'path': '', 21:04:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:04:12 INFO - Running post-action listener: _resource_record_post_action 21:04:12 INFO - [mozharness: 2016-12-01 05:04:12.485195Z] Finished populate-webroot step (success) 21:04:12 INFO - [mozharness: 2016-12-01 05:04:12.485293Z] Running create-virtualenv step. 21:04:12 INFO - Running pre-action listener: _resource_record_pre_action 21:04:12 INFO - Running main action method: create_virtualenv 21:04:12 INFO - Creating virtualenv /builds/slave/test/build/venv 21:04:12 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 21:04:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:04:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:04:12 INFO - Using real prefix '/usr' 21:04:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:04:13 INFO - Installing distribute.............................................................................................................................................................................................done. 21:04:15 INFO - Installing pip.................done. 21:04:15 INFO - Return code: 0 21:04:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:04:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:15 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 0x7fe75913df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cbf60>, '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 0x23ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cd1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480566404.276316-1892045505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:04:15 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 21:04:15 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 21:04:15 INFO - Using env: {'DISPLAY': ':0', 21:04:15 INFO - 'HOME': '/home/cltbld', 21:04:15 INFO - 'LANG': 'en_US.UTF-8', 21:04:15 INFO - 'LANGUAGE': 'en_US:en', 21:04:15 INFO - 'LOGNAME': 'cltbld', 21:04:15 INFO - 'MAIL': '/var/mail/cltbld', 21:04:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:15 INFO - 'MOZ_NO_REMOTE': '1', 21:04:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:15 INFO - 'NO_EM_RESTART': '1', 21:04:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:15 INFO - 'PWD': '/builds/slave/test', 21:04:15 INFO - 'SHELL': '/bin/bash', 21:04:15 INFO - 'SHLVL': '1', 21:04:15 INFO - 'TERM': 'linux', 21:04:15 INFO - 'TMOUT': '86400', 21:04:15 INFO - 'USER': 'cltbld', 21:04:15 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480566404.276316-1892045505', 21:04:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:15 INFO - '_': '/tools/buildbot/bin/python'} 21:04:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:15 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 21:04:15 INFO - Cleaning up... 21:04:15 INFO - Return code: 0 21:04:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:04:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:15 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 0x7fe75913df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cbf60>, '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 0x23ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cd1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480566404.276316-1892045505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:04:15 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 21:04:15 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 21:04:15 INFO - Using env: {'DISPLAY': ':0', 21:04:15 INFO - 'HOME': '/home/cltbld', 21:04:15 INFO - 'LANG': 'en_US.UTF-8', 21:04:15 INFO - 'LANGUAGE': 'en_US:en', 21:04:15 INFO - 'LOGNAME': 'cltbld', 21:04:15 INFO - 'MAIL': '/var/mail/cltbld', 21:04:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:15 INFO - 'MOZ_NO_REMOTE': '1', 21:04:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:15 INFO - 'NO_EM_RESTART': '1', 21:04:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:15 INFO - 'PWD': '/builds/slave/test', 21:04:15 INFO - 'SHELL': '/bin/bash', 21:04:15 INFO - 'SHLVL': '1', 21:04:15 INFO - 'TERM': 'linux', 21:04:15 INFO - 'TMOUT': '86400', 21:04:15 INFO - 'USER': 'cltbld', 21:04:15 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480566404.276316-1892045505', 21:04:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:15 INFO - '_': '/tools/buildbot/bin/python'} 21:04:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:15 INFO - Downloading/unpacking psutil>=3.1.1 21:04:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:04:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:04:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:04:17 INFO - Installing collected packages: psutil 21:04:17 INFO - Running setup.py install for psutil 21:04:17 INFO - building 'psutil._psutil_linux' extension 21:04:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:04:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:04:17 INFO - building 'psutil._psutil_posix' extension 21:04:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:04:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:04:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:04:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:04:18 INFO - Successfully installed psutil 21:04:18 INFO - Cleaning up... 21:04:18 INFO - Return code: 0 21:04:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe75913df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cbf60>, '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 0x23ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cd1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480566404.276316-1892045505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:04:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:04:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:04:18 INFO - Using env: {'DISPLAY': ':0', 21:04:18 INFO - 'HOME': '/home/cltbld', 21:04:18 INFO - 'LANG': 'en_US.UTF-8', 21:04:18 INFO - 'LANGUAGE': 'en_US:en', 21:04:18 INFO - 'LOGNAME': 'cltbld', 21:04:18 INFO - 'MAIL': '/var/mail/cltbld', 21:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:18 INFO - 'MOZ_NO_REMOTE': '1', 21:04:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:18 INFO - 'NO_EM_RESTART': '1', 21:04:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:18 INFO - 'PWD': '/builds/slave/test', 21:04:18 INFO - 'SHELL': '/bin/bash', 21:04:18 INFO - 'SHLVL': '1', 21:04:18 INFO - 'TERM': 'linux', 21:04:18 INFO - 'TMOUT': '86400', 21:04:18 INFO - 'USER': 'cltbld', 21:04:18 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480566404.276316-1892045505', 21:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:18 INFO - '_': '/tools/buildbot/bin/python'} 21:04:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:04:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:04:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:04:20 INFO - Installing collected packages: mozsystemmonitor 21:04:20 INFO - Running setup.py install for mozsystemmonitor 21:04:20 INFO - Successfully installed mozsystemmonitor 21:04:20 INFO - Cleaning up... 21:04:20 INFO - Return code: 0 21:04:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:04:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe75913df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cbf60>, '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 0x23ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cd1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480566404.276316-1892045505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:04:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:04:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:04:20 INFO - Using env: {'DISPLAY': ':0', 21:04:20 INFO - 'HOME': '/home/cltbld', 21:04:20 INFO - 'LANG': 'en_US.UTF-8', 21:04:20 INFO - 'LANGUAGE': 'en_US:en', 21:04:20 INFO - 'LOGNAME': 'cltbld', 21:04:20 INFO - 'MAIL': '/var/mail/cltbld', 21:04:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:20 INFO - 'MOZ_NO_REMOTE': '1', 21:04:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:20 INFO - 'NO_EM_RESTART': '1', 21:04:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:20 INFO - 'PWD': '/builds/slave/test', 21:04:20 INFO - 'SHELL': '/bin/bash', 21:04:20 INFO - 'SHLVL': '1', 21:04:20 INFO - 'TERM': 'linux', 21:04:20 INFO - 'TMOUT': '86400', 21:04:20 INFO - 'USER': 'cltbld', 21:04:20 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480566404.276316-1892045505', 21:04:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:20 INFO - '_': '/tools/buildbot/bin/python'} 21:04:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:20 INFO - Downloading/unpacking jsonschema==2.5.1 21:04:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:04:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:04:22 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 21:04:22 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 21:04:22 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 21:04:22 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 21:04:22 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 21:04:22 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 21:04:22 INFO - Downloading functools32-3.2.3-2.tar.gz 21:04:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:04:22 INFO - warning: no files found matching '*.txt' 21:04:22 INFO - no previously-included directories found matching 'build' 21:04:22 INFO - no previously-included directories found matching 'dist' 21:04:22 INFO - no previously-included directories found matching '.git*' 21:04:22 INFO - Installing collected packages: jsonschema, functools32 21:04:23 INFO - Running setup.py install for functools32 21:04:23 INFO - warning: no files found matching '*.txt' 21:04:23 INFO - no previously-included directories found matching 'build' 21:04:23 INFO - no previously-included directories found matching 'dist' 21:04:23 INFO - no previously-included directories found matching '.git*' 21:04:23 INFO - Successfully installed jsonschema functools32 21:04:23 INFO - Cleaning up... 21:04:23 INFO - Return code: 0 21:04:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:04:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe75913df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cbf60>, '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 0x23ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cd1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480566404.276316-1892045505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:04:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:04:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:04:23 INFO - Using env: {'DISPLAY': ':0', 21:04:23 INFO - 'HOME': '/home/cltbld', 21:04:23 INFO - 'LANG': 'en_US.UTF-8', 21:04:23 INFO - 'LANGUAGE': 'en_US:en', 21:04:23 INFO - 'LOGNAME': 'cltbld', 21:04:23 INFO - 'MAIL': '/var/mail/cltbld', 21:04:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:23 INFO - 'MOZ_NO_REMOTE': '1', 21:04:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:23 INFO - 'NO_EM_RESTART': '1', 21:04:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:23 INFO - 'PWD': '/builds/slave/test', 21:04:23 INFO - 'SHELL': '/bin/bash', 21:04:23 INFO - 'SHLVL': '1', 21:04:23 INFO - 'TERM': 'linux', 21:04:23 INFO - 'TMOUT': '86400', 21:04:23 INFO - 'USER': 'cltbld', 21:04:23 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480566404.276316-1892045505', 21:04:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:23 INFO - '_': '/tools/buildbot/bin/python'} 21:04:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:04:23 INFO - Cleaning up... 21:04:23 INFO - Return code: 0 21:04:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:04:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe75913df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cbf60>, '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 0x23ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cd1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480566404.276316-1892045505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:04:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:04:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:04:23 INFO - Using env: {'DISPLAY': ':0', 21:04:23 INFO - 'HOME': '/home/cltbld', 21:04:23 INFO - 'LANG': 'en_US.UTF-8', 21:04:23 INFO - 'LANGUAGE': 'en_US:en', 21:04:23 INFO - 'LOGNAME': 'cltbld', 21:04:23 INFO - 'MAIL': '/var/mail/cltbld', 21:04:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:23 INFO - 'MOZ_NO_REMOTE': '1', 21:04:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:23 INFO - 'NO_EM_RESTART': '1', 21:04:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:23 INFO - 'PWD': '/builds/slave/test', 21:04:23 INFO - 'SHELL': '/bin/bash', 21:04:23 INFO - 'SHLVL': '1', 21:04:23 INFO - 'TERM': 'linux', 21:04:23 INFO - 'TMOUT': '86400', 21:04:23 INFO - 'USER': 'cltbld', 21:04:23 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480566404.276316-1892045505', 21:04:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:23 INFO - '_': '/tools/buildbot/bin/python'} 21:04:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:23 INFO - Downloading/unpacking blobuploader==1.2.4 21:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:25 INFO - Downloading blobuploader-1.2.4.tar.gz 21:04:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:04:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:04:25 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 21:04:25 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 21:04:25 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 21:04:25 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 21:04:25 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 21:04:25 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 21:04:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:04:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:26 INFO - Downloading docopt-0.6.1.tar.gz 21:04:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:04:26 INFO - Installing collected packages: blobuploader, requests, docopt 21:04:26 INFO - Running setup.py install for blobuploader 21:04:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:04:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:04:26 INFO - Running setup.py install for requests 21:04:26 INFO - Running setup.py install for docopt 21:04:26 INFO - Successfully installed blobuploader requests docopt 21:04:26 INFO - Cleaning up... 21:04:27 INFO - Return code: 0 21:04:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:04:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:27 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 0x7fe75913df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cbf60>, '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 0x23ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cd1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480566404.276316-1892045505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:04:27 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 21:04:27 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 21:04:27 INFO - Using env: {'DISPLAY': ':0', 21:04:27 INFO - 'HOME': '/home/cltbld', 21:04:27 INFO - 'LANG': 'en_US.UTF-8', 21:04:27 INFO - 'LANGUAGE': 'en_US:en', 21:04:27 INFO - 'LOGNAME': 'cltbld', 21:04:27 INFO - 'MAIL': '/var/mail/cltbld', 21:04:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:27 INFO - 'MOZ_NO_REMOTE': '1', 21:04:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:27 INFO - 'NO_EM_RESTART': '1', 21:04:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:27 INFO - 'PWD': '/builds/slave/test', 21:04:27 INFO - 'SHELL': '/bin/bash', 21:04:27 INFO - 'SHLVL': '1', 21:04:27 INFO - 'TERM': 'linux', 21:04:27 INFO - 'TMOUT': '86400', 21:04:27 INFO - 'USER': 'cltbld', 21:04:27 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480566404.276316-1892045505', 21:04:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:27 INFO - '_': '/tools/buildbot/bin/python'} 21:04:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:04:27 INFO - Running setup.py (path:/tmp/pip-4rt9KB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:04:27 INFO - Running setup.py (path:/tmp/pip-09oSgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:04:27 INFO - Running setup.py (path:/tmp/pip-ZVPLX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:04:27 INFO - Running setup.py (path:/tmp/pip-k9_aGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:04:27 INFO - Running setup.py (path:/tmp/pip-wo4vV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:04:27 INFO - Running setup.py (path:/tmp/pip-zU5069-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:04:27 INFO - Running setup.py (path:/tmp/pip-rip_i_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:04:27 INFO - Running setup.py (path:/tmp/pip-Z4vCOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:04:27 INFO - Running setup.py (path:/tmp/pip-XVM7Zm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:04:27 INFO - Running setup.py (path:/tmp/pip-8vL6jG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:04:27 INFO - Running setup.py (path:/tmp/pip-it9f1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:04:28 INFO - Running setup.py (path:/tmp/pip-sD9bSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:04:28 INFO - Running setup.py (path:/tmp/pip-Ej612k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:04:28 INFO - Running setup.py (path:/tmp/pip-C0BsIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:04:28 INFO - Running setup.py (path:/tmp/pip-6QgC8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:04:28 INFO - Running setup.py (path:/tmp/pip-X_CIkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:04:28 INFO - Running setup.py (path:/tmp/pip-ee9Io3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:04:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:04:28 INFO - Running setup.py install for manifestparser 21:04:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:04:28 INFO - Running setup.py install for mozcrash 21:04:28 INFO - Running setup.py install for mozdebug 21:04:28 INFO - Running setup.py install for mozdevice 21:04:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:04:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:04:28 INFO - Running setup.py install for mozfile 21:04:28 INFO - Running setup.py install for mozhttpd 21:04:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:04:29 INFO - Running setup.py install for mozinfo 21:04:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:04:29 INFO - Running setup.py install for mozInstall 21:04:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:04:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:04:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:04:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:04:29 INFO - Running setup.py install for mozleak 21:04:29 INFO - Running setup.py install for mozlog 21:04:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:04:29 INFO - Running setup.py install for moznetwork 21:04:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:04:29 INFO - Running setup.py install for mozprocess 21:04:29 INFO - Running setup.py install for mozprofile 21:04:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:04:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:04:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:04:29 INFO - Running setup.py install for mozrunner 21:04:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:04:29 INFO - Running setup.py install for mozscreenshot 21:04:30 INFO - Running setup.py install for moztest 21:04:30 INFO - Running setup.py install for mozversion 21:04:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:04:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:04:30 INFO - Cleaning up... 21:04:30 INFO - Return code: 0 21:04:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:30 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 0x7fe75913df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cbf60>, '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 0x23ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cd1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480566404.276316-1892045505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:04:30 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 21:04:30 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 21:04:30 INFO - Using env: {'DISPLAY': ':0', 21:04:30 INFO - 'HOME': '/home/cltbld', 21:04:30 INFO - 'LANG': 'en_US.UTF-8', 21:04:30 INFO - 'LANGUAGE': 'en_US:en', 21:04:30 INFO - 'LOGNAME': 'cltbld', 21:04:30 INFO - 'MAIL': '/var/mail/cltbld', 21:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:30 INFO - 'MOZ_NO_REMOTE': '1', 21:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:30 INFO - 'NO_EM_RESTART': '1', 21:04:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:30 INFO - 'PWD': '/builds/slave/test', 21:04:30 INFO - 'SHELL': '/bin/bash', 21:04:30 INFO - 'SHLVL': '1', 21:04:30 INFO - 'TERM': 'linux', 21:04:30 INFO - 'TMOUT': '86400', 21:04:30 INFO - 'USER': 'cltbld', 21:04:30 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480566404.276316-1892045505', 21:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:30 INFO - '_': '/tools/buildbot/bin/python'} 21:04:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:04:30 INFO - Running setup.py (path:/tmp/pip-f5x7M4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:04:30 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)) 21:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:04:30 INFO - Running setup.py (path:/tmp/pip-XmEZje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:04:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 21:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:04:30 INFO - Running setup.py (path:/tmp/pip-g0uUch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:04:30 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)) 21:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:04:30 INFO - Running setup.py (path:/tmp/pip-2HkR2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:04:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 21:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:04:30 INFO - Running setup.py (path:/tmp/pip-fLNfL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:04:30 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)) 21:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:04:30 INFO - Running setup.py (path:/tmp/pip-FA1XyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:04:30 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)) 21:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:04:30 INFO - Running setup.py (path:/tmp/pip-YqwZgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:04:30 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)) 21:04:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:04:30 INFO - Running setup.py (path:/tmp/pip-LU_jGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:04:31 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)) 21:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:04:31 INFO - Running setup.py (path:/tmp/pip-ukOYaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:04:31 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)) 21:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:04:31 INFO - Running setup.py (path:/tmp/pip-o37m0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:04:31 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)) 21:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:04:31 INFO - Running setup.py (path:/tmp/pip-4j8ubk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:04:31 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)) 21:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:04:31 INFO - Running setup.py (path:/tmp/pip-9F0LK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:04:31 INFO - Running setup.py (path:/tmp/pip-QjN4VS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:04:31 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)) 21:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:04:31 INFO - Running setup.py (path:/tmp/pip-8t1E3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 21:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:04:31 INFO - Running setup.py (path:/tmp/pip-W64dep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:04:31 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)) 21:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:04:31 INFO - Running setup.py (path:/tmp/pip-RS2YG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:04:31 INFO - Running setup.py (path:/tmp/pip-MSj8Kl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:04:31 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)) 21:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:04:31 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)) 21:04:31 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:04:31 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:04:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:33 INFO - Downloading blessings-1.6.tar.gz 21:04:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:04:33 INFO - Installing collected packages: blessings 21:04:33 INFO - Running setup.py install for blessings 21:04:33 INFO - Successfully installed blessings 21:04:33 INFO - Cleaning up... 21:04:33 INFO - Return code: 0 21:04:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:04:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:04:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:04:34 INFO - Reading from file tmpfile_stdout 21:04:34 INFO - Current package versions: 21:04:34 INFO - argparse == 1.2.1 21:04:34 INFO - blessings == 1.6 21:04:34 INFO - blobuploader == 1.2.4 21:04:34 INFO - docopt == 0.6.1 21:04:34 INFO - functools32 == 3.2.3-2 21:04:34 INFO - jsonschema == 2.5.1 21:04:34 INFO - manifestparser == 1.1 21:04:34 INFO - mozInstall == 1.12 21:04:34 INFO - mozcrash == 0.17 21:04:34 INFO - mozdebug == 0.1 21:04:34 INFO - mozdevice == 0.48 21:04:34 INFO - mozfile == 1.2 21:04:34 INFO - mozhttpd == 0.7 21:04:34 INFO - mozinfo == 0.9 21:04:34 INFO - mozleak == 0.1 21:04:34 INFO - mozlog == 3.4 21:04:34 INFO - moznetwork == 0.27 21:04:34 INFO - mozprocess == 0.23 21:04:34 INFO - mozprofile == 0.28 21:04:34 INFO - mozrunner == 6.12 21:04:34 INFO - mozscreenshot == 0.1 21:04:34 INFO - mozsystemmonitor == 0.3 21:04:34 INFO - moztest == 0.7 21:04:34 INFO - mozversion == 1.4 21:04:34 INFO - psutil == 3.1.1 21:04:34 INFO - requests == 1.2.3 21:04:34 INFO - wsgiref == 0.1.2 21:04:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:34 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 0x7fe75913df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cbf60>, '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 0x23ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cd1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480566404.276316-1892045505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:04:34 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 21:04:34 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 21:04:34 INFO - Using env: {'DISPLAY': ':0', 21:04:34 INFO - 'HOME': '/home/cltbld', 21:04:34 INFO - 'LANG': 'en_US.UTF-8', 21:04:34 INFO - 'LANGUAGE': 'en_US:en', 21:04:34 INFO - 'LOGNAME': 'cltbld', 21:04:34 INFO - 'MAIL': '/var/mail/cltbld', 21:04:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:34 INFO - 'MOZ_NO_REMOTE': '1', 21:04:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:34 INFO - 'NO_EM_RESTART': '1', 21:04:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:34 INFO - 'PWD': '/builds/slave/test', 21:04:34 INFO - 'SHELL': '/bin/bash', 21:04:34 INFO - 'SHLVL': '1', 21:04:34 INFO - 'TERM': 'linux', 21:04:34 INFO - 'TMOUT': '86400', 21:04:34 INFO - 'USER': 'cltbld', 21:04:34 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480566404.276316-1892045505', 21:04:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:34 INFO - '_': '/tools/buildbot/bin/python'} 21:04:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:34 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)) 21:04:34 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)) 21:04:34 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)) 21:04:34 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)) 21:04:34 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)) 21:04:34 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)) 21:04:34 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)) 21:04:34 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)) 21:04:34 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)) 21:04:34 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)) 21:04:34 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)) 21:04:34 INFO - Cleaning up... 21:04:34 INFO - Return code: 0 21:04:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:34 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 0x7fe75913df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cbf60>, '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 0x23ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cd1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480566404.276316-1892045505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:04:34 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 21:04:34 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 21:04:34 INFO - Using env: {'DISPLAY': ':0', 21:04:34 INFO - 'HOME': '/home/cltbld', 21:04:34 INFO - 'LANG': 'en_US.UTF-8', 21:04:34 INFO - 'LANGUAGE': 'en_US:en', 21:04:34 INFO - 'LOGNAME': 'cltbld', 21:04:34 INFO - 'MAIL': '/var/mail/cltbld', 21:04:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:34 INFO - 'MOZ_NO_REMOTE': '1', 21:04:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:34 INFO - 'NO_EM_RESTART': '1', 21:04:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:34 INFO - 'PWD': '/builds/slave/test', 21:04:34 INFO - 'SHELL': '/bin/bash', 21:04:34 INFO - 'SHLVL': '1', 21:04:34 INFO - 'TERM': 'linux', 21:04:34 INFO - 'TMOUT': '86400', 21:04:34 INFO - 'USER': 'cltbld', 21:04:34 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480566404.276316-1892045505', 21:04:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:34 INFO - '_': '/tools/buildbot/bin/python'} 21:04:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:04:34 INFO - Cleaning up... 21:04:34 INFO - Return code: 0 21:04:34 INFO - Running post-action listener: _resource_record_post_action 21:04:34 INFO - Running post-action listener: _start_resource_monitoring 21:04:34 INFO - Starting resource monitoring. 21:04:34 INFO - [mozharness: 2016-12-01 05:04:34.641724Z] Finished create-virtualenv step (success) 21:04:34 INFO - [mozharness: 2016-12-01 05:04:34.642307Z] Running install step. 21:04:34 INFO - Running pre-action listener: _resource_record_pre_action 21:04:34 INFO - Running main action method: install 21:04:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:04:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:04:34 INFO - Reading from file tmpfile_stdout 21:04:34 INFO - Detecting whether we're running mozinstall >=1.0... 21:04:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:04:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:04:34 INFO - Reading from file tmpfile_stdout 21:04:34 INFO - Output received: 21:04:34 INFO - Usage: mozinstall [options] installer 21:04:34 INFO - Options: 21:04:34 INFO - -h, --help show this help message and exit 21:04:34 INFO - -d DEST, --destination=DEST 21:04:34 INFO - Directory to install application into. [default: 21:04:34 INFO - "/builds/slave/test"] 21:04:34 INFO - --app=APP Application being installed. [default: firefox] 21:04:34 INFO - mkdir: /builds/slave/test/build/application 21:04:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:04:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:04:48 INFO - Reading from file tmpfile_stdout 21:04:48 INFO - Output received: 21:04:48 INFO - /builds/slave/test/build/application/firefox/firefox 21:04:48 INFO - Running post-action listener: _resource_record_post_action 21:04:48 INFO - [mozharness: 2016-12-01 05:04:48.457048Z] Finished install step (success) 21:04:48 INFO - [mozharness: 2016-12-01 05:04:48.457295Z] Running run-tests step. 21:04:48 INFO - Running pre-action listener: _resource_record_pre_action 21:04:48 INFO - Running main action method: run_tests 21:04:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:04:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:04:48 INFO - Python 2.7.3 21:04:48 INFO - Return code: 0 21:04:48 INFO - grabbing minidump binary from tooltool 21:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:48 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/linux64/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 0x23cbf60>, '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 0x23ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cd1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:04:48 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:04:48 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/linux64/releng.manifest -o -c /builds/tooltool_cache 21:04:48 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:04:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:04:48 INFO - Return code: 0 21:04:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:04:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:04:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:04:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:04:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:04:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KHWzPn8aRuWqCFdxt2NrPQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 21:04:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KHWzPn8aRuWqCFdxt2NrPQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 21:04:48 INFO - Using env: {'DISPLAY': ':0', 21:04:48 INFO - 'HOME': '/home/cltbld', 21:04:48 INFO - 'LANG': 'en_US.UTF-8', 21:04:48 INFO - 'LANGUAGE': 'en_US:en', 21:04:48 INFO - 'LOGNAME': 'cltbld', 21:04:48 INFO - 'MAIL': '/var/mail/cltbld', 21:04:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:04:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:48 INFO - 'MOZ_NO_REMOTE': '1', 21:04:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:48 INFO - 'NO_EM_RESTART': '1', 21:04:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:48 INFO - 'PWD': '/builds/slave/test', 21:04:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:04:48 INFO - 'SHELL': '/bin/bash', 21:04:48 INFO - 'SHLVL': '1', 21:04:48 INFO - 'TERM': 'linux', 21:04:48 INFO - 'TMOUT': '86400', 21:04:48 INFO - 'USER': 'cltbld', 21:04:48 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1480566404.276316-1892045505', 21:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:48 INFO - '_': '/tools/buildbot/bin/python'} 21:04:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KHWzPn8aRuWqCFdxt2NrPQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 21:04:48 INFO - mozversion application_buildid: 20161130182143 21:04:48 INFO - mozversion application_changeset: 63121d897767457eaae42cfe5371268274f145c8 21:04:48 INFO - mozversion application_display_name: Firefox 21:04:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:04:48 INFO - mozversion application_name: Firefox 21:04:48 INFO - mozversion application_remotingname: firefox 21:04:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 21:04:48 INFO - mozversion application_vendor: Mozilla 21:04:48 INFO - mozversion application_version: 51.0 21:04:48 INFO - mozversion platform_buildid: 20161130182143 21:04:48 INFO - mozversion platform_changeset: 63121d897767457eaae42cfe5371268274f145c8 21:04:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 21:04:48 INFO - mozversion platform_version: 51.0 21:04:48 INFO - using testdate: 1480568688 21:04:48 INFO - actual date: 1480568688 21:04:48 INFO - starting webserver on 'localhost:44525' 21:04:48 INFO - SUITE-START | Running 2 tests 21:04:48 INFO - TEST-START | dromaeo_css 21:04:48 INFO - operating with platform_type : linux_ 21:04:48 INFO - Initialising browser for dromaeo_css test... 21:04:48 INFO - TEST-INFO | started process 10573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkwgU1J/profile http://localhost:44525/getInfo.html) 21:04:52 INFO - PROCESS | 10573 | __metrics Screen width/height:1600/1200 21:04:52 INFO - PROCESS | 10573 | colorDepth:24 21:04:52 INFO - PROCESS | 10573 | Browser inner width/height: 1024/697 21:04:52 INFO - PROCESS | 10573 | __metrics 21:04:53 INFO - PROCESS | 10573 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:04:53 INFO - PROCESS | 10573 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:04:53 INFO - PROCESS | 10573 | console.error: PushService: 21:04:53 INFO - PROCESS | 10573 | stateChangeProcessEnqueue: Error transitioning state 21:04:53 INFO - PROCESS | 10573 | UnknownError 21:04:54 INFO - TEST-INFO | 10573: exit 0 21:04:54 INFO - Browser initialized. 21:04:54 INFO - Running cycle 1/1 for dromaeo_css test... 21:04:54 INFO - TEST-INFO | started process 10663 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkwgU1J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:05:06 INFO - PROCESS | 10663 | RSS: Main: 142893056 21:05:06 INFO - PROCESS | 10663 | 21:05:57 INFO - PROCESS | 10663 | 1480568757134 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:08:06 INFO - PROCESS | 10663 | Cycle 1(1): loaded http://localhost:44525/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44525/tests/dromaeo/cssquery-ext.html) 21:08:07 INFO - PROCESS | 10663 | RSS: Main: 233664512 21:08:07 INFO - PROCESS | 10663 | 21:11:09 INFO - PROCESS | 10663 | Cycle 1(1): loaded http://localhost:44525/tests/dromaeo/cssquery-ext.html (next: http://localhost:44525/tests/dromaeo/cssquery-jquery.html) 21:11:10 INFO - PROCESS | 10663 | RSS: Main: 236122112 21:11:10 INFO - PROCESS | 10663 | 21:14:11 INFO - PROCESS | 10663 | Cycle 1(1): loaded http://localhost:44525/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44525/tests/dromaeo/cssquery-mootools.html) 21:14:12 INFO - PROCESS | 10663 | RSS: Main: 196407296 21:14:12 INFO - PROCESS | 10663 | 21:17:14 INFO - PROCESS | 10663 | Cycle 1(1): loaded http://localhost:44525/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44525/tests/dromaeo/cssquery-prototype.html) 21:17:15 INFO - PROCESS | 10663 | RSS: Main: 175640576 21:17:15 INFO - PROCESS | 10663 | 21:20:17 INFO - PROCESS | 10663 | Cycle 1(1): loaded http://localhost:44525/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44525/tests/dromaeo/cssquery-yui.html) 21:20:18 INFO - PROCESS | 10663 | RSS: Main: 175816704 21:20:18 INFO - PROCESS | 10663 | 21:23:20 INFO - PROCESS | 10663 | Cycle 1(1): loaded http://localhost:44525/tests/dromaeo/cssquery-yui.html (next: http://localhost:44525/tests/dromaeo/cssquery-dojo.html) 21:23:20 INFO - PROCESS | 10663 | RSS: Main: 258310144 21:23:20 INFO - PROCESS | 10663 | 21:23:20 INFO - PROCESS | 10663 | __start_tp_report 21:23:20 INFO - PROCESS | 10663 | _x_x_mozilla_page_load 21:23:20 INFO - PROCESS | 10663 | _x_x_mozilla_page_load_details 21:23:20 INFO - PROCESS | 10663 | |i|pagename|runs| 21:23:20 INFO - PROCESS | 10663 | |0;dojo.html;3104.844757762112;3169.730572901304;3175.095097897098;3195.137312925509;3211.3095684427844;5608.186812912125;5697.059985102458;5698.401667824881;5718.685472299022;5720.971395143024;5671.631343962639;5744.913826292609;5749.252597162374;5752.050911599581;5754.769809207637;5145.253938178962;5205.16717325228;5208.218767184915;5227.242049902762;5267.051930652481;5017.949820501803;5253.395859476152;5273.630845840793;5278.551323137538;5300.310959575249;4986.551210391064;5121.795128194868;5156.639035267533;5159.948400515985;5162.019216348882;5191.221316802472;5205.531502164805;5278.366596008465;5279.472052794728;5300.2049692546425;5005.199168133081;5107.9744601277125;5187.844364669066;5227.529522343008;5253.028189784902;5526.613137080406;5544.944550554484;5608.719564021823;5612.69130197839;5642.040853054949;6036.788712395045;6048.062550304666;6068.57519973602;6073.240844894388;6075.119107729354;5869.471747542699;6102.664353460558;6117.847053823645;6129.908051379233;6130.540209484262;5515.283013208297;5627.380988091307;5656.321241451011;5680.5455563554815;5759.481646651821;6263.718132683949;6271.498280137669;6276.592021518587;6279.591826531261;6284.465820405226;5992.161097446361;5999.670018148957;6016.157737916695;6016.278046634345;6017.1275165100815;5888.205092312483;5931.4958228550195;5971.373005834412;5984.401559843981;6076.787312444043;6085.148079268906;6088.178095956989;6107.053406721965;6118.418750218722;6134.570580059442;6080.391960803884;6084.209052823193;6092.817215483543;6125.908111378333;6140.631562106288;4571.382863313476;4612.515685852937;4652.790624421909;4704.858854234379;4722.669413141047;4125.5874412558505;4167.624913757776;4173.9582604173565;4189.601987811153;4226.556211597799;5782.335031471434;5848.590598658138;5852.180694702745;5860.238169037998;5865.677387743715;5879.353271140171;6219.813405597839;6225.750969961241;6232.065190221412;6234.1583886175695;5579.7489112990015;5743.4256574342235;5796.536277097822;5807.419258074243;5875.706214689249;5292.338457692788;5299.5230429261555;5303.416624171338;5305.098133317345;5308.044551980681;6312.4634406076;6359.141515895295;6362.586431881913;6368.140301059298;6375.776847810212;5898.94101058984;5953.851153721192;6041.18444010053;6096.9390306096375;6106.358832322542;6252;6264.812055638338;6308.747650093945;6314.842128946813;6319.494440444661;6075.301340345917;6075.48112971757;6077.453029227391;6078.787242446493;6082.482988945989;5827.59206855533;5954.374790647093;6074.544409169242;6091.42131497507;6142.170806941184;6013.879722405615;6047.606905551125;6059.848503787441;6061.575689701678;6098.878022439615;6027.939720602913;6031.517478601613;6031.517478601789;6034.185384972972;6034.456898879122;5750.7987220447085;5825;5884.529237661062;6002.699865006645;6017;5934.050551911673;6038.879222415615;6043.063325184604;6056.273247210363;6059.33347331802;5777.566682498746;5819;5860.531157507304;5862.530997520103;5866.090755932837 21:23:20 INFO - PROCESS | 10663 | |1;ext.html;591.6627522312281;610.4322979628945;630.4735545819241;631.4033238589532;643.1606753187095;36806;37325.44011839821;46096.76951615242;47146.76426617862;47179;48598.51401485993;48876.266855997186;48944.75527622357;49073.754631226795;49199.26201106986;9285.396449230795;9449.76375590609;9452.81094378112;9457.243420526342;9467.100625440573;8263.62813673383;8472.534010629413;11005.229633925628;11260.436978151101;11266.43667816606;11302.039326657245;11388.487518061707;11399.886001139965;11400.657980260605;11415.714607134847;11185.384803835745;11197.888021119767;11267.267627604262;11275.66173014811;11282.266652667551;11023.06303964164;11086.556537738481;11089.27919685226;11091.778164436746;11098.55605775768;44597.77701111474;44619.553804461866;44684;44912.77543612294;44949.32576011362;3856.382978723419;3887.786171760552;3970.06703424695;3978.8408463661417;4553.4991150973365;33715.83142084299;33790;34069.48895766566;34198.82900585506;35772.46341304883;4647.34937108805;4648.883777905546;4671.602913752301;4741.976290118528;4748.833790817339;322848;322881;323288;323625;324077;64848.67575662091;64911.35088649053;65254.34745652578;65275.67362163254;65535;40281.59718402837;41009;41262.793686031975;43721.78139109284;43727.56272437298;19026.904865475582;19093.331733389543;19157.32949346794;19207.32774352919;19244.903775481314;12871.613851584467;13001.219926804422;14493.565193044225;14585.343659535347;14616.707665846623;20299.492512687302;20770.688439673417;20783.896080519502;21232.89383553103;21666.56666866654;7493.962530187314;7730.96134519335;7754.651040703182;7769.223077692299;7806.102298235662;974.4202199691173;1011.2404416315704;1069.5989004123298;1094.5074716377662;1100.1638754546602;34521.48217776736;34540.309193815985;34664.26678666107;34719.479207811906;34831.82584087114;1177.9941100294443;1190.494040033;1211.787937111002;1230.9076819238594;1255.6358655989661;17965.281388744304;18181;18181.909090454465;18195.337139207302;18222.180001899946;531282;541328;547369;547453;548173;60626.696866516264;60807.39192608106;61037;61148;61245.38754612486;1322.6098301001227;1324.8675132486674;1382.7372799168127;1416.2706206303762;1416.3626368134176;31316.843415782776;34663.306733865684;34985.65014349926;35503.82248088743;35538.64461355354;52061.7396913013;52445.47554524406;52454.21318680299;52536.73731631317;52560.73719631377;399176;399504;400080;400108;400913;27163.320916977234;27730.86134569314;29790.404191915608;30293.848530757205;30365.240868978453;48698.26952595643;48703.5129648699;48807.511924880295;49200;50476.49523504718;41238.58761412468;42226.155476889675;42510.92886663092;43068.35397469103;43231.78384108059;42338.788306058275;42533.787331064384;42973.570264296955;43525.78237108794;43753;42684.78657606692;43127.35308970431;43829.780851095544;44004.33993490164;44036.11927761363;35823.64176358307;36986.44520332251;37528.92385902425;37878.8106059468;37970.34207605552;28755.562221888402;28907.566386503797;28963.710362896945;29218.7078129216;29335.85332073326 21:23:20 INFO - PROCESS | 10663 | |2;jquery.html;412.9896752581187;414.50880706362943;426.0775421213074;427.529717310958;442.63924901205513;18878.62242755144;19298.228070877165;20336.694949575733;20581.073851676672;20675.069621867013;18838.81161188391;18873.339433119843;18912.58155638329;18985.525361865926;19064.046797660096;5813.82558523245;6126.17296664949;6135.938640613582;6139.539534534905;6140.7850725224625;5844.064949608063;5973.671448070354;6013.278406591216;6101.633901965874;6109.297430795449;5997.700114994254;6001.459868611824;6002.759889604411;6009.759609615632;6016.127661489081;5894.233749612566;6002.429769171922;6003.129546215796;6087.878242435127;6123.877522449526;6005.3394126646035;6009.1587177795145;6015.518758499309;6015.608985415934;6016.338202797689;15257.313420895975;15328.463503777315;15341.693166136727;15990.20048997557;16317.91841040799;2392.2823153054014;2439.121916110199;2457.8402403843693;2527.064985955208;2548.2992177151245;10793.62222322215;10974.396408197546;11243.325400475916;13772.380242889094;13782.793258101035;1975.9506012349661;1992.8804271743597;2072.471519762466;2102.096098677568;2109.4199095248778;63181.68409157971;63824.361756382306;78514;79952.99999999942;81380.59309703473;11722.120840936965;11904.702382440335;11983.640490785116;12063.457144428521;12084.516619335129;17048.48854534366;17048.57378565521;17118.743218851727;17152.31390744381;17166.65666686659;8942.642294308285;9033.141851524095;9165.083491650916;9226.677066302647;9324.906750932403;8910.643574257087;8943.040932184032;8951.955240223757;9041.367104302635;9086;5146.4853514648985;5223.895522089537;5257.947420525746;5261.815836445706;5367.812126575551;2004.7393838800863;2117.5965279407983;2118.375079351595;2139.893005349726;2190.7371115466244;953.2135987810084;995.4027583449872;1078.8867168947147;1113.2151832957745;1116.4919961417536;19619.411417657495;19918.30285939985;19920.90039549793;20090.19639214415;20256.89871550633;1091.2961140064615;1096.5230124895536;1121.3664279682116;1122.9157813164045;1160.825876118572;10861.402622855661;11183.608573699881;11184.161187910939;11205.215634905479;11295.830562541569;483138;486156.751275117;495794;501386;503100;94511;96554;96853;97183.05633887283;98447;1036.2953191829629;1037.901399367059;1039.9792004159874;1045.8797238317538;1076.34343050739;17291.56771080733;17651.911740441217;18151.546211344823;18283.634327313113;18426.815731843046;28729.425411491236;31435.685643144192;39329.41005884971;42416.36375454309;44717.77641111774;59443;62136.68931655313;65742;66308.33691663021;66781.66609166923;8381.37139714536;9443.150116489274;9456.621735130793;9563.713088607354;9576.856347154659;14126.858731412965;14175;14180.858191417954;14696.55910322692;14885.851141488447;12008.699782505508;12159.392030398622;12314.322712250912;12353.876461235273;12429.564965226175;12213.206141600767;12308.938455307667;12372.690682733004;12506.374681266083;12844.678883027625;12320.75358492843;12383.380830958597;12453.626391208278;12697.365131743562;12876.806847897476;9170.358074934691;9233.722988310361;9287.071292870658;9598.95200523993;9693.9030609693;9849.556769945513;11561.88438115608;12092.637220883387;12307.630771076882;12529.561465349034 21:23:20 INFO - PROCESS | 10663 | |3;mootools.html;1527.5799155232307;1546.7138579362818;1675.1289329548636;1792.3905872003515;1845.8061903500131;8648.870266945993;9309.953450232739;9337.25301975842;9338.719838404842;9340.719778406641;8207.712730054449;8491.023532293788;8792;9029.32280078995;9145.08549145085;2484.2919767866115;2496.7877730392847;2512.5351809915223;2512.6105453654623;2517.2070797698757;2405.56699794037;2519.3071905226025;2521.319243804172;2521.9117330893423;2524.2805800346905;2448.7306396296394;2451.8651474168914;2522.9495410091786;2524.179641616473;2526.68416447944;2437.744036876129;2438.231956933569;2450.987745061281;2485.478049609584;2493.47636996231;2359.3629719975684;2364.5034542746043;2368.5144545368157;2370.988145059281;2521.697396312436;9311.115444032806;9344.345895787297;9399.765005874908;9425.38734982224;9434.05659434058;5526.253955715967;5649.604527683064;5658.830235092953;5667.291588551431;5670.6030577859565;3360.1431634932937;3403.6426175251736;3503.6496350365014;3513.332466831294;3517.402041652925;1164.2548768787983;1185.25921299188;1210.8365370675021;1238.0652607281445;1240.6526172671665;12370.257784532956;12416.130870839044;12429.192102513398;12477;12477.126601137925;4767.594754445841;4786.569208771228;4799.18413869643;4901.068796928572;4981.2030075187795;10596.417197054081;10599.682009539572;10609.363438193734;10614;10649.84025239622;5562.02664533705;5569.582281328835;5579.191017302468;5584.329880414376;5585.1901474286815;4458.977705111519;4621.653375996813;5050.545450909436;5070.062038522885;5136.332276804066;4191.119864828359;4285.957140428618;4353.542877997828;4385.561443855589;4389.29771236607;1336.652470357714;1353.1813252982001;1358.2393859438746;1362.7615167345675;1379.4482207117233;1031.5718976624767;1036.6164519127972;1037.8910214427528;1041.9114375278034;1055.889131641182;6237.688115594293;6422.42198202164;6428.19647544057;6459.935400646027;6554.770583029571;1005.6178652112151;1040.1626690514208;1045.3988956350129;1067.8947289555274;1091.3888222595372;4164.104717485755;4316.2446571849805;4454.26504626733;4516.254817955067;4555.612772914273;11247.100231981422;11493.42532873353;11567.42162891852;11570.652880413601;11640.592579259684;10374.481275936172;11480.196386253048;11498.827517587242;11537.711557211136;11541.134414918915;8435.831283374298;8721.694740684046;8726.301895848444;8733.956330218309;8739.43193692408;6395.688883778907;6416.550841441241;6478.287388387368;6622.337766223339;6715.56348837324;10622.415767132881;10672.359658420519;10682.412467314372;10793.244472886823;10805.729856753329;10226.846597301195;10686.145108391465;10694.679159625224;10907.672769816918;11026.173037022416;7412.62936853166;7654;8277.58612069406;8461.703840365557;8467;8691.087435819401;8872.689455869013;9060.093990600888;9095.909040909772;9101.499417532099;7885.6451459685595;7912.762617121495;7919.12889582134;7954.443188976716;8007.359411247203;7639.656215470206;7666.425018123551;7890.408219383455;7908.8813667793875;8010.158933312151;7309.122905251404;7357.889631655423;7408.851822963403;7428.554286742813;7462.291082347168;5320.122179840438;5342.973285133705;5373;5439.646422982493;5446.264754258124;5578.525825304732;5603.495685388335;5635.971820140873;5647.1529270609735;5832.50423713989 21:23:20 INFO - PROCESS | 10663 | |4;prototype.html;346.43531044397633;353.09403608303654;357.6888107346609;360.02433405471186;361.54625944439726;5501.174823776436;5570.777168913243;5574.777008919648;5599.524040456561;5649.689267090308;5502.422245664207;5538.3692745945655;5545.639533430324;5558.499735023847;5575.219469274305;3769.886903392889;4107.322291821846;4236.195122926634;4314.417553630266;4320.891977700551;4304.698671093025;4308.289132293168;4311.116221174668;4331.631811296043;4331.935020974688;4255.446791917062;4310.97844510777;4320.265554855682;4321.589449002356;4331.740095594275;4245.469316335458;4291.54938731435;4303.612674859246;4317.43873296471;4329.653627709776;3857.1514266861245;3858.9228215435814;3864.091938394475;3865.2269546090893;3895.883123506271;5282.947170528322;5369.382521010095;5404.081306177959;5421.241026256327;5449.591280653927;4826.300186472977;4963;4995.700257984533;5030.245463180516;5060.443351231362;5728.2242504823635;5729.627574207663;5745.339285982123;5745.454181852718;5748.655080695172;4262.680298977558;4266.911937455929;4273.893152671208;4276.444062271916;4279.679024073207;5734.483896449298;5914.733836977303;5920.733566989496;6008.699565021775;6012.939870601282;4322.530339684522;4323.2434323993175;4328.956710432918;4336.522982471925;4339.240632889295;4416.602505774432;4423.845165419195;4436.511983681792;4441.977790111029;4459.531749166355;4678.555537223959;4919.704817710949;4976.875578110504;4980.203167493184;5005.224190250517;5761.049426844607;5761.9135712964335;5776.451237132465;5780.68772491007;5849.766009359663;1482.7849961755485;1510.6601014771588;1515.4014164404998;1519.7188520123811;1525.6948610277766;913.8400779863497;962.5908988679784;962.6341990043878;963.6193703487083;981.2444417798256;4928.728919909439;4931.58081563064;4936.580390666833;4956.274049272885;4962.578180854595;5173.456787037382;5173.948260517422;5178.171492561172;5199.246109314128;5218.478152184827;4651.395318608559;4871.585915197177;4916.5004673574185;4926;4927.852164435073;2768.9030883918967;2781.3463835998523;2781.374190807093;2798.726579406365;2802.5936239245193;5281.656692314988;5302.3637163540625;5311.654742441729;5328.6802791832615;5347.491988261109;5243.606729495303;5288.334174734946;5711.400302968129;5825.825225243249;6130.693465326716;5999.820005399845;6006;6114.868749281308;6126.693665316806;6136.938630613726;5994.67029313392;6018;6022.698865056817;6073.726682299219;6113.969430152821;5607.971960140173;5861.824145275648;5911.467967882739;5924.407559244041;5940;6151.507879369729;6167.753289868535;6182.536309776695;6192.411720886508;6224.844378890382;4091.89770255746;4354.063876266618;4364.7162934410435;4366.388705581157;4387.091615147421;5843.853903652443;5891.617044892068;5930.487725629937;5935.584509084322;5943.673097979479;5784.5083167929515;5793.449622285876;5814.418558144321;5858.765649373977;5868.4424979626865;5596.524295434933;5755.251817263729;5762.337331206797;5764.164196191613;5767.077267637158;5749.281339832521;5767.423257674199;5769.336526299361;5779.508741756829;5786.537077033743;5614.9719251403485;5800.839832033525;5804.709764511842;5807.593468457168;5829.679367634821;5645.802396916089;5666.235058267246;5697.800576979786;5707.400722924033;5718.8570285741525 21:23:20 INFO - PROCESS | 10663 | |5;yui.html;784.9725259615915;835.5655059369128;873.580681272989;878.477306002928;908.3913777768894;14519.20144392058;15304.69390612187;15413.460528881491;15455.922720386396;15464.149471779061;14510.347034383452;15227.695446091071;15939.681206375866;16092.356305747786;16115.355385784555;825.3892119831312;871.1201686296854;877.4822854515835;884.0496466298722;884.460479107747;735.698363670895;751.9511231769917;871.0984131423977;882.7175303902753;895.3687650206589;941.1247539787994;942.7030485397112;943.6131186213654;944;944.2681921510849;929.5166513413055;935.5883411299006;935.672514619881;936.063936063936;936.8220038192721;692.3526502719973;692.9792106236821;693.1370443797454;693.2893783871572;693.3309356471029;15502;15510.750941113589;15559.766603500957;15561.066336019761;15594.064356138668;15331.310091045929;16444.34222631093;16493.609026313345;16922.323107075703;16998.235079421454;13133.86866131336;13249;13275.402606882617;13394.330283485786;13599;4158.272302347077;4169.353750168729;4215.894602634959;4241.27898257297;4300.462442194726;73311.63344183245;75789;77326.61336693281;83855.16144838596;85666;11644.941775291069;12034.217775844541;12216.26702397859;12618.81071783924;12881.484740610458;21990.89004554967;22059.779402206095;22086.447838803837;22095;22111;9615.326927115175;9675.177609903238;9718.173955213744;9750.902490974999;9831.852522212173;5079.08576456234;5229.111051121318;5265.52610265078;5305.8938821223355;5353.330833645794;3908.785016824102;4081.6530594899173;4083.5099788025627;4083.97958010214;4120.423140760296;664.4916638771343;677.376813331736;685.3934268172703;704.8167476456158;707.6178863413699;674.0024763350269;686.0224180542806;723.2767232767233;769.7113582406597;816.4529765057425;10093;10310.793784124275;10578.10086142671;10826.133909287239;11417.143714221467;735.8270806360501;766.0964942866474;772.7527191298731;789.5460110436522;798.4291231769313;4984.177610694195;5395.325584301962;5414.783408663609;5430.131179011419;5433.646812957145;118322;121739;121881;124070.37964810118;124540.37729811293;110120.4493977525;110327;110473.44763276292;111751;112778;91964;95500.52249738846;97248;98345;98766.99999999856;10136.44249566281;10155.796884062129;10213.846792297973;10326.173906087344;10462.68611941643;57858;58593.12110318263;58963.705181473815;59493.70253148706;62242.377576223655;75802;82079;86315.1368486307;88355;88960;12501.374931253218;12918.289494077915;13235.80146297787;13293.20240785556;13363.799543006668;14723.411063557338;14806.925965370105;14820.184889831164;14874.107553546823;15453.150076745887;14319;14600.415983360546;15181.316840742415;15235.3905843765;15365;13880.583582492542;14107.576772696835;14215.786763198354;14253.50112746049;14985.250737462866;12096.637100886988;14098.859011409755;14207.934404919466;14307.35616897263;14857.851421486079;11263.268377693139;12236.938815305866;12405.503779848705;12465.626031219077;13362.064655474023;12045.81931271014;12540.372981351078;12750.892502975084;12919.870801291867;12959.963202943552 21:23:20 INFO - PROCESS | 10663 | __end_tp_report 21:23:20 INFO - PROCESS | 10663 | __start_cc_report 21:23:20 INFO - PROCESS | 10663 | _x_x_mozilla_cycle_collect,853 21:23:20 INFO - PROCESS | 10663 | __end_cc_report 21:23:20 INFO - PROCESS | 10663 | __startTimestamp1480569800889__endTimestamp 21:23:20 INFO - PROCESS | 10663 | 21:23:20 INFO - PROCESS | 10663 | ------- Summary: start ------- 21:23:20 INFO - PROCESS | 10663 | Number of tests: 6 21:23:20 INFO - PROCESS | 10663 | 21:23:20 INFO - PROCESS | 10663 | [#0] dojo.html Cycles:165 Average:5663.26 Median:5869.47 stddev:658.56 (11.2%) stddev-sans-first:629.25 21:23:20 INFO - PROCESS | 10663 | Values: 3104.8 3169.7 3175.1 3195.1 3211.3 5608.2 5697.1 5698.4 5718.7 5721.0 5671.6 5744.9 5749.3 5752.1 5754.8 5145.3 5205.2 5208.2 5227.2 5267.1 5017.9 5253.4 5273.6 5278.6 5300.3 4986.6 5121.8 5156.6 5159.9 5162.0 5191.2 5205.5 5278.4 5279.5 5300.2 5005.2 5108.0 5187.8 5227.5 5253.0 5526.6 5544.9 5608.7 5612.7 5642.0 6036.8 6048.1 6068.6 6073.2 6075.1 5869.5 6102.7 6117.8 6129.9 6130.5 5515.3 5627.4 5656.3 5680.5 5759.5 6263.7 6271.5 6276.6 6279.6 6284.5 5992.2 5999.7 6016.2 6016.3 6017.1 5888.2 5931.5 5971.4 5984.4 6076.8 6085.1 6088.2 6107.1 6118.4 6134.6 6080.4 6084.2 6092.8 6125.9 6140.6 4571.4 4612.5 4652.8 4704.9 4722.7 4125.6 4167.6 4174.0 4189.6 4226.6 5782.3 5848.6 5852.2 5860.2 5865.7 5879.4 6219.8 6225.8 6232.1 6234.2 5579.7 5743.4 5796.5 5807.4 5875.7 5292.3 5299.5 5303.4 5305.1 5308.0 6312.5 6359.1 6362.6 6368.1 6375.8 5898.9 5953.9 6041.2 6096.9 6106.4 6252.0 6264.8 6308.7 6314.8 6319.5 6075.3 6075.5 6077.5 6078.8 6082.5 5827.6 5954.4 6074.5 6091.4 6142.2 6013.9 6047.6 6059.8 6061.6 6098.9 6027.9 6031.5 6031.5 6034.2 6034.5 5750.8 5825.0 5884.5 6002.7 6017.0 5934.1 6038.9 6043.1 6056.3 6059.3 5777.6 5819.0 5860.5 5862.5 5866.1 21:23:20 INFO - PROCESS | 10663 | 21:23:20 INFO - PROCESS | 10663 | [#1] ext.html Cycles:180 Average:59625.61 Median:3928.93 stddev:114201.58 (2906.7%) stddev-sans-first:114435.93 21:23:20 INFO - PROCESS | 10663 | Values: 591.7 610.4 630.5 631.4 643.2 36806.0 37325.4 46096.8 47146.8 47179.0 48598.5 48876.3 48944.8 49073.8 49199.3 9285.4 9449.8 9452.8 9457.2 9467.1 8263.6 8472.5 11005.2 11260.4 11266.4 11302.0 11388.5 11399.9 11400.7 11415.7 11185.4 11197.9 11267.3 11275.7 11282.3 11023.1 11086.6 11089.3 11091.8 11098.6 44597.8 44619.6 44684.0 44912.8 44949.3 3856.4 3887.8 3970.1 3978.8 4553.5 33715.8 33790.0 34069.5 34198.8 35772.5 4647.3 4648.9 4671.6 4742.0 4748.8 322848.0 322881.0 323288.0 323625.0 324077.0 64848.7 64911.4 65254.3 65275.7 65535.0 40281.6 41009.0 41262.8 43721.8 43727.6 19026.9 19093.3 19157.3 19207.3 19244.9 12871.6 13001.2 14493.6 14585.3 14616.7 20299.5 20770.7 20783.9 21232.9 21666.6 7494.0 7731.0 7754.7 7769.2 7806.1 974.4 1011.2 1069.6 1094.5 1100.2 34521.5 34540.3 34664.3 34719.5 34831.8 1178.0 1190.5 1211.8 1230.9 1255.6 17965.3 18181.0 18181.9 18195.3 18222.2 531282.0 541328.0 547369.0 547453.0 548173.0 60626.7 60807.4 61037.0 61148.0 61245.4 1322.6 1324.9 1382.7 1416.3 1416.4 31316.8 34663.3 34985.7 35503.8 35538.6 52061.7 52445.5 52454.2 52536.7 52560.7 399176.0 399504.0 400080.0 400108.0 400913.0 27163.3 27730.9 29790.4 30293.8 30365.2 48698.3 48703.5 48807.5 49200.0 50476.5 41238.6 42226.2 42510.9 43068.4 43231.8 42338.8 42533.8 42973.6 43525.8 43753.0 42684.8 43127.4 43829.8 44004.3 44036.1 35823.6 36986.4 37528.9 37878.8 37970.3 28755.6 28907.6 28963.7 29218.7 29335.9 21:23:20 INFO - PROCESS | 10663 | 21:23:20 INFO - PROCESS | 10663 | [#2] jquery.html Cycles:180 Average:29332.42 Median:2165.32 stddev:81398.01 (3759.2%) stddev-sans-first:81597.39 21:23:20 INFO - PROCESS | 10663 | Values: 413.0 414.5 426.1 427.5 442.6 18878.6 19298.2 20336.7 20581.1 20675.1 18838.8 18873.3 18912.6 18985.5 19064.0 5813.8 6126.2 6135.9 6139.5 6140.8 5844.1 5973.7 6013.3 6101.6 6109.3 5997.7 6001.5 6002.8 6009.8 6016.1 5894.2 6002.4 6003.1 6087.9 6123.9 6005.3 6009.2 6015.5 6015.6 6016.3 15257.3 15328.5 15341.7 15990.2 16317.9 2392.3 2439.1 2457.8 2527.1 2548.3 10793.6 10974.4 11243.3 13772.4 13782.8 1976.0 1992.9 2072.5 2102.1 2109.4 63181.7 63824.4 78514.0 79953.0 81380.6 11722.1 11904.7 11983.6 12063.5 12084.5 17048.5 17048.6 17118.7 17152.3 17166.7 8942.6 9033.1 9165.1 9226.7 9324.9 8910.6 8943.0 8952.0 9041.4 9086.0 5146.5 5223.9 5257.9 5261.8 5367.8 2004.7 2117.6 2118.4 2139.9 2190.7 953.2 995.4 1078.9 1113.2 1116.5 19619.4 19918.3 19920.9 20090.2 20256.9 1091.3 1096.5 1121.4 1122.9 1160.8 10861.4 11183.6 11184.2 11205.2 11295.8 483138.0 486156.8 495794.0 501386.0 503100.0 94511.0 96554.0 96853.0 97183.1 98447.0 1036.3 1037.9 1040.0 1045.9 1076.3 17291.6 17651.9 18151.5 18283.6 18426.8 28729.4 31435.7 39329.4 42416.4 44717.8 59443.0 62136.7 65742.0 66308.3 66781.7 8381.4 9443.2 9456.6 9563.7 9576.9 14126.9 14175.0 14180.9 14696.6 14885.9 12008.7 12159.4 12314.3 12353.9 12429.6 12213.2 12308.9 12372.7 12506.4 12844.7 12320.8 12383.4 12453.6 12697.4 12876.8 9170.4 9233.7 9287.1 9599.0 9693.9 9849.6 11561.9 12092.6 12307.6 12529.6 21:23:20 INFO - PROCESS | 10663 | 21:23:20 INFO - PROCESS | 10663 | [#3] mootools.html Cycles:180 Average:6088.98 Median:4387.43 stddev:3402.76 (77.6%) stddev-sans-first:3395.04 21:23:20 INFO - PROCESS | 10663 | Values: 1527.6 1546.7 1675.1 1792.4 1845.8 8648.9 9310.0 9337.3 9338.7 9340.7 8207.7 8491.0 8792.0 9029.3 9145.1 2484.3 2496.8 2512.5 2512.6 2517.2 2405.6 2519.3 2521.3 2521.9 2524.3 2448.7 2451.9 2522.9 2524.2 2526.7 2437.7 2438.2 2451.0 2485.5 2493.5 2359.4 2364.5 2368.5 2371.0 2521.7 9311.1 9344.3 9399.8 9425.4 9434.1 5526.3 5649.6 5658.8 5667.3 5670.6 3360.1 3403.6 3503.6 3513.3 3517.4 1164.3 1185.3 1210.8 1238.1 1240.7 12370.3 12416.1 12429.2 12477.0 12477.1 4767.6 4786.6 4799.2 4901.1 4981.2 10596.4 10599.7 10609.4 10614.0 10649.8 5562.0 5569.6 5579.2 5584.3 5585.2 4459.0 4621.7 5050.5 5070.1 5136.3 4191.1 4286.0 4353.5 4385.6 4389.3 1336.7 1353.2 1358.2 1362.8 1379.4 1031.6 1036.6 1037.9 1041.9 1055.9 6237.7 6422.4 6428.2 6459.9 6554.8 1005.6 1040.2 1045.4 1067.9 1091.4 4164.1 4316.2 4454.3 4516.3 4555.6 11247.1 11493.4 11567.4 11570.7 11640.6 10374.5 11480.2 11498.8 11537.7 11541.1 8435.8 8721.7 8726.3 8734.0 8739.4 6395.7 6416.6 6478.3 6622.3 6715.6 10622.4 10672.4 10682.4 10793.2 10805.7 10226.8 10686.1 10694.7 10907.7 11026.2 7412.6 7654.0 8277.6 8461.7 8467.0 8691.1 8872.7 9060.1 9095.9 9101.5 7885.6 7912.8 7919.1 7954.4 8007.4 7639.7 7666.4 7890.4 7908.9 8010.2 7309.1 7357.9 7408.9 7428.6 7462.3 5320.1 5343.0 5373.0 5439.6 5446.3 5578.5 5603.5 5636.0 5647.2 5832.5 21:23:20 INFO - PROCESS | 10663 | 21:23:20 INFO - PROCESS | 10663 | [#4] prototype.html Cycles:180 Average:4792.55 Median:5320.17 stddev:1401.74 (26.3%) stddev-sans-first:1365.37 21:23:20 INFO - PROCESS | 10663 | Values: 346.4 353.1 357.7 360.0 361.5 5501.2 5570.8 5574.8 5599.5 5649.7 5502.4 5538.4 5545.6 5558.5 5575.2 3769.9 4107.3 4236.2 4314.4 4320.9 4304.7 4308.3 4311.1 4331.6 4331.9 4255.4 4311.0 4320.3 4321.6 4331.7 4245.5 4291.5 4303.6 4317.4 4329.7 3857.2 3858.9 3864.1 3865.2 3895.9 5282.9 5369.4 5404.1 5421.2 5449.6 4826.3 4963.0 4995.7 5030.2 5060.4 5728.2 5729.6 5745.3 5745.5 5748.7 4262.7 4266.9 4273.9 4276.4 4279.7 5734.5 5914.7 5920.7 6008.7 6012.9 4322.5 4323.2 4329.0 4336.5 4339.2 4416.6 4423.8 4436.5 4442.0 4459.5 4678.6 4919.7 4976.9 4980.2 5005.2 5761.0 5761.9 5776.5 5780.7 5849.8 1482.8 1510.7 1515.4 1519.7 1525.7 913.8 962.6 962.6 963.6 981.2 4928.7 4931.6 4936.6 4956.3 4962.6 5173.5 5173.9 5178.2 5199.2 5218.5 4651.4 4871.6 4916.5 4926.0 4927.9 2768.9 2781.3 2781.4 2798.7 2802.6 5281.7 5302.4 5311.7 5328.7 5347.5 5243.6 5288.3 5711.4 5825.8 6130.7 5999.8 6006.0 6114.9 6126.7 6136.9 5994.7 6018.0 6022.7 6073.7 6114.0 5608.0 5861.8 5911.5 5924.4 5940.0 6151.5 6167.8 6182.5 6192.4 6224.8 4091.9 4354.1 4364.7 4366.4 4387.1 5843.9 5891.6 5930.5 5935.6 5943.7 5784.5 5793.4 5814.4 5858.8 5868.4 5596.5 5755.3 5762.3 5764.2 5767.1 5749.3 5767.4 5769.3 5779.5 5786.5 5615.0 5800.8 5804.7 5807.6 5829.7 5645.8 5666.2 5697.8 5707.4 5718.9 21:23:20 INFO - PROCESS | 10663 | 21:23:20 INFO - PROCESS | 10663 | [#5] yui.html Cycles:180 Average:22663.30 Median:3995.22 stddev:32819.03 (821.5%) stddev-sans-first:32869.98 21:23:20 INFO - PROCESS | 10663 | Values: 785.0 835.6 873.6 878.5 908.4 14519.2 15304.7 15413.5 15455.9 15464.1 14510.3 15227.7 15939.7 16092.4 16115.4 825.4 871.1 877.5 884.0 884.5 735.7 752.0 871.1 882.7 895.4 941.1 942.7 943.6 944.0 944.3 929.5 935.6 935.7 936.1 936.8 692.4 693.0 693.1 693.3 693.3 15502.0 15510.8 15559.8 15561.1 15594.1 15331.3 16444.3 16493.6 16922.3 16998.2 13133.9 13249.0 13275.4 13394.3 13599.0 4158.3 4169.4 4215.9 4241.3 4300.5 73311.6 75789.0 77326.6 83855.2 85666.0 11644.9 12034.2 12216.3 12618.8 12881.5 21990.9 22059.8 22086.4 22095.0 22111.0 9615.3 9675.2 9718.2 9750.9 9831.9 5079.1 5229.1 5265.5 5305.9 5353.3 3908.8 4081.7 4083.5 4084.0 4120.4 664.5 677.4 685.4 704.8 707.6 674.0 686.0 723.3 769.7 816.5 10093.0 10310.8 10578.1 10826.1 11417.1 735.8 766.1 772.8 789.5 798.4 4984.2 5395.3 5414.8 5430.1 5433.6 118322.0 121739.0 121881.0 124070.4 124540.4 110120.4 110327.0 110473.4 111751.0 112778.0 91964.0 95500.5 97248.0 98345.0 98767.0 10136.4 10155.8 10213.8 10326.2 10462.7 57858.0 58593.1 58963.7 59493.7 62242.4 75802.0 82079.0 86315.1 88355.0 88960.0 12501.4 12918.3 13235.8 13293.2 13363.8 14723.4 14806.9 14820.2 14874.1 15453.2 14319.0 14600.4 15181.3 15235.4 15365.0 13880.6 14107.6 14215.8 14253.5 14985.3 12096.6 14098.9 14207.9 14307.4 14857.9 11263.3 12236.9 12405.5 12465.6 13362.1 12045.8 12540.4 12750.9 12919.9 12960.0 21:23:20 INFO - PROCESS | 10663 | -------- Summary: end -------- 21:23:20 INFO - PROCESS | 10663 | 21:23:21 INFO - TEST-INFO | 10663: exit 0 21:23:21 INFO - TEST-OK | dromaeo_css | took 1112926ms 21:23:21 INFO - TEST-START | kraken 21:23:21 INFO - operating with platform_type : linux_ 21:23:21 INFO - Initialising browser for kraken test... 21:23:21 INFO - TEST-INFO | started process 10976 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZGEoLI/profile http://localhost:44525/getInfo.html) 21:23:25 INFO - PROCESS | 10976 | __metrics Screen width/height:1600/1200 21:23:25 INFO - PROCESS | 10976 | colorDepth:24 21:23:25 INFO - PROCESS | 10976 | Browser inner width/height: 1024/697 21:23:25 INFO - PROCESS | 10976 | __metrics 21:23:26 INFO - PROCESS | 10976 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:23:26 INFO - PROCESS | 10976 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:23:26 INFO - PROCESS | 10976 | console.error: PushService: 21:23:26 INFO - PROCESS | 10976 | stateChangeProcessEnqueue: Error transitioning state 21:23:26 INFO - PROCESS | 10976 | UnknownError 21:23:27 INFO - TEST-INFO | 10976: exit 0 21:23:27 INFO - Browser initialized. 21:23:27 INFO - Running cycle 1/1 for kraken test... 21:23:27 INFO - TEST-INFO | started process 11068 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZGEoLI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:23:39 INFO - PROCESS | 11068 | RSS: Main: 143777792 21:23:39 INFO - PROCESS | 11068 | 21:23:41 INFO - PROCESS | 11068 | Cycle 1(1): loaded http://localhost:44525/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44525/tests/kraken/driver.html?testName=audio-beat-detection) 21:23:42 INFO - PROCESS | 11068 | RSS: Main: 187424768 21:23:42 INFO - PROCESS | 11068 | 21:23:45 INFO - PROCESS | 11068 | Cycle 1(1): loaded http://localhost:44525/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44525/tests/kraken/driver.html?testName=audio-dft) 21:23:45 INFO - PROCESS | 11068 | RSS: Main: 174403584 21:23:45 INFO - PROCESS | 11068 | 21:23:48 INFO - PROCESS | 11068 | Cycle 1(1): loaded http://localhost:44525/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44525/tests/kraken/driver.html?testName=audio-fft) 21:23:49 INFO - PROCESS | 11068 | RSS: Main: 266403840 21:23:49 INFO - PROCESS | 11068 | 21:23:51 INFO - PROCESS | 11068 | Cycle 1(1): loaded http://localhost:44525/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44525/tests/kraken/driver.html?testName=audio-oscillator) 21:23:51 INFO - PROCESS | 11068 | RSS: Main: 172662784 21:23:51 INFO - PROCESS | 11068 | 21:23:53 INFO - PROCESS | 11068 | Cycle 1(1): loaded http://localhost:44525/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44525/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:23:54 INFO - PROCESS | 11068 | RSS: Main: 174034944 21:23:54 INFO - PROCESS | 11068 | 21:23:57 INFO - PROCESS | 11068 | Cycle 1(1): loaded http://localhost:44525/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44525/tests/kraken/driver.html?testName=imaging-darkroom) 21:23:57 INFO - PROCESS | 11068 | RSS: Main: 210665472 21:23:57 INFO - PROCESS | 11068 | 21:24:01 INFO - PROCESS | 11068 | Cycle 1(1): loaded http://localhost:44525/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44525/tests/kraken/driver.html?testName=imaging-desaturate) 21:24:01 INFO - PROCESS | 11068 | RSS: Main: 209260544 21:24:01 INFO - PROCESS | 11068 | 21:24:04 INFO - PROCESS | 11068 | Cycle 1(1): loaded http://localhost:44525/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44525/tests/kraken/driver.html?testName=json-parse-financial) 21:24:05 INFO - PROCESS | 11068 | RSS: Main: 209264640 21:24:05 INFO - PROCESS | 11068 | 21:24:06 INFO - PROCESS | 11068 | Cycle 1(1): loaded http://localhost:44525/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44525/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:24:07 INFO - PROCESS | 11068 | RSS: Main: 170897408 21:24:07 INFO - PROCESS | 11068 | 21:24:08 INFO - PROCESS | 11068 | Cycle 1(1): loaded http://localhost:44525/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44525/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:24:09 INFO - PROCESS | 11068 | RSS: Main: 177582080 21:24:09 INFO - PROCESS | 11068 | 21:24:11 INFO - PROCESS | 11068 | Cycle 1(1): loaded http://localhost:44525/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44525/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:24:12 INFO - PROCESS | 11068 | RSS: Main: 186912768 21:24:12 INFO - PROCESS | 11068 | 21:24:14 INFO - PROCESS | 11068 | Cycle 1(1): loaded http://localhost:44525/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44525/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:24:15 INFO - PROCESS | 11068 | RSS: Main: 196448256 21:24:15 INFO - PROCESS | 11068 | 21:24:17 INFO - PROCESS | 11068 | Cycle 1(1): loaded http://localhost:44525/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44525/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:24:18 INFO - PROCESS | 11068 | RSS: Main: 193339392 21:24:18 INFO - PROCESS | 11068 | 21:24:20 INFO - PROCESS | 11068 | Cycle 1(1): loaded http://localhost:44525/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44525/tests/kraken/driver.html?testName=ai-astar) 21:24:20 INFO - PROCESS | 11068 | RSS: Main: 245088256 21:24:20 INFO - PROCESS | 11068 | 21:24:20 INFO - PROCESS | 11068 | __start_tp_report 21:24:20 INFO - PROCESS | 11068 | _x_x_mozilla_page_load 21:24:20 INFO - PROCESS | 11068 | _x_x_mozilla_page_load_details 21:24:20 INFO - PROCESS | 11068 | |i|pagename|runs| 21:24:20 INFO - PROCESS | 11068 | |0;ai-astar;111;111;111;110;111;112;111;112;109;111 21:24:20 INFO - PROCESS | 11068 | |1;audio-beat-detection;152;117;122;154;121;122;116;120;149;123 21:24:20 INFO - PROCESS | 11068 | |2;audio-dft;165;161;160;161;162;162;161;163;163;161 21:24:20 INFO - PROCESS | 11068 | |3;audio-fft;75;75;76;105;76;76;76;76;107;75 21:24:20 INFO - PROCESS | 11068 | |4;audio-oscillator;81;82;116;83;84;82;105;82;83;109 21:24:20 INFO - PROCESS | 11068 | |5;imaging-gaussian-blur;116;118;117;118;116;117;117;117;117;117 21:24:20 INFO - PROCESS | 11068 | |6;imaging-darkroom;147;145;147;145;148;146;148;147;147;148 21:24:20 INFO - PROCESS | 11068 | |7;imaging-desaturate;97;95;94;96;95;94;95;96;95;95 21:24:20 INFO - PROCESS | 11068 | |8;json-parse-financial;48;49;50;50;49;52;50;49;50;49 21:24:20 INFO - PROCESS | 11068 | |9;json-stringify-tinderbox;58;60;59;60;58;59;59;59;60;58 21:24:20 INFO - PROCESS | 11068 | |10;stanford-crypto-aes;74;74;76;74;74;74;73;74;81;74 21:24:20 INFO - PROCESS | 11068 | |11;stanford-crypto-ccm;128;124;130;127;123;138;132;121;170;123 21:24:20 INFO - PROCESS | 11068 | |12;stanford-crypto-pbkdf2;155;160;155;157;157;158;155;155;155;155 21:24:20 INFO - PROCESS | 11068 | |13;stanford-crypto-sha256-iterative;65;63;64;62;62;63;62;65;61;62 21:24:20 INFO - PROCESS | 11068 | __end_tp_report 21:24:20 INFO - PROCESS | 11068 | __start_cc_report 21:24:20 INFO - PROCESS | 11068 | _x_x_mozilla_cycle_collect,1607 21:24:20 INFO - PROCESS | 11068 | __end_cc_report 21:24:20 INFO - PROCESS | 11068 | __startTimestamp1480569860479__endTimestamp 21:24:20 INFO - PROCESS | 11068 | 21:24:20 INFO - PROCESS | 11068 | ------- Summary: start ------- 21:24:20 INFO - PROCESS | 11068 | Number of tests: 14 21:24:20 INFO - PROCESS | 11068 | 21:24:20 INFO - PROCESS | 11068 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:0.88 (0.8%) stddev-sans-first:0.93 21:24:20 INFO - PROCESS | 11068 | Values: 111.0 111.0 111.0 110.0 111.0 112.0 111.0 112.0 109.0 111.0 21:24:20 INFO - PROCESS | 11068 | 21:24:20 INFO - PROCESS | 11068 | [#1] audio-beat-detection Cycles:10 Average:129.60 Median:122.50 stddev:15.43 (12.6%) stddev-sans-first:14.08 21:24:20 INFO - PROCESS | 11068 | Values: 152.0 117.0 122.0 154.0 121.0 122.0 116.0 120.0 149.0 123.0 21:24:20 INFO - PROCESS | 11068 | 21:24:20 INFO - PROCESS | 11068 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.45 (0.9%) stddev-sans-first:1.01 21:24:20 INFO - PROCESS | 11068 | Values: 165.0 161.0 160.0 161.0 162.0 162.0 161.0 163.0 163.0 161.0 21:24:20 INFO - PROCESS | 11068 | 21:24:20 INFO - PROCESS | 11068 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:12.82 (16.9%) stddev-sans-first:13.37 21:24:20 INFO - PROCESS | 11068 | Values: 75.0 75.0 76.0 105.0 76.0 76.0 76.0 76.0 107.0 75.0 21:24:20 INFO - PROCESS | 11068 | 21:24:20 INFO - PROCESS | 11068 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:82.00 stddev:13.60 (16.6%) stddev-sans-first:13.96 21:24:20 INFO - PROCESS | 11068 | Values: 81.0 82.0 116.0 83.0 84.0 82.0 105.0 82.0 83.0 109.0 21:24:20 INFO - PROCESS | 11068 | 21:24:20 INFO - PROCESS | 11068 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 21:24:20 INFO - PROCESS | 11068 | Values: 116.0 118.0 117.0 118.0 116.0 117.0 117.0 117.0 117.0 117.0 21:24:20 INFO - PROCESS | 11068 | 21:24:20 INFO - PROCESS | 11068 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:1.14 (0.8%) stddev-sans-first:1.20 21:24:20 INFO - PROCESS | 11068 | Values: 147.0 145.0 147.0 145.0 148.0 146.0 148.0 147.0 147.0 148.0 21:24:20 INFO - PROCESS | 11068 | 21:24:20 INFO - PROCESS | 11068 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.92 (1.0%) stddev-sans-first:0.71 21:24:20 INFO - PROCESS | 11068 | Values: 97.0 95.0 94.0 96.0 95.0 94.0 95.0 96.0 95.0 95.0 21:24:20 INFO - PROCESS | 11068 | 21:24:20 INFO - PROCESS | 11068 | [#8] json-parse-financial Cycles:10 Average:49.60 Median:50.00 stddev:1.07 (2.1%) stddev-sans-first:0.97 21:24:20 INFO - PROCESS | 11068 | Values: 48.0 49.0 50.0 50.0 49.0 52.0 50.0 49.0 50.0 49.0 21:24:20 INFO - PROCESS | 11068 | 21:24:20 INFO - PROCESS | 11068 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:0.82 (1.4%) stddev-sans-first:0.78 21:24:20 INFO - PROCESS | 11068 | Values: 58.0 60.0 59.0 60.0 58.0 59.0 59.0 59.0 60.0 58.0 21:24:20 INFO - PROCESS | 11068 | 21:24:20 INFO - PROCESS | 11068 | [#10] stanford-crypto-aes Cycles:10 Average:74.80 Median:74.00 stddev:2.30 (3.1%) stddev-sans-first:2.42 21:24:20 INFO - PROCESS | 11068 | Values: 74.0 74.0 76.0 74.0 74.0 74.0 73.0 74.0 81.0 74.0 21:24:20 INFO - PROCESS | 11068 | 21:24:20 INFO - PROCESS | 11068 | [#11] stanford-crypto-ccm Cycles:10 Average:131.60 Median:129.00 stddev:14.42 (11.2%) stddev-sans-first:15.23 21:24:20 INFO - PROCESS | 11068 | Values: 128.0 124.0 130.0 127.0 123.0 138.0 132.0 121.0 170.0 123.0 21:24:20 INFO - PROCESS | 11068 | 21:24:20 INFO - PROCESS | 11068 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.20 Median:156.00 stddev:1.75 (1.1%) stddev-sans-first:1.80 21:24:20 INFO - PROCESS | 11068 | Values: 155.0 160.0 155.0 157.0 157.0 158.0 155.0 155.0 155.0 155.0 21:24:20 INFO - PROCESS | 11068 | 21:24:20 INFO - PROCESS | 11068 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:1.37 (2.2%) stddev-sans-first:1.22 21:24:20 INFO - PROCESS | 11068 | Values: 65.0 63.0 64.0 62.0 62.0 63.0 62.0 65.0 61.0 62.0 21:24:20 INFO - PROCESS | 11068 | -------- Summary: end -------- 21:24:20 INFO - PROCESS | 11068 | 21:24:21 INFO - TEST-INFO | 11068: exit 0 21:24:21 INFO - TEST-OK | kraken | took 59896ms 21:24:21 INFO - SUITE-END | took 1172s 21:24:21 INFO - Completed test suite (00:19:32) 21:24:21 INFO - javascript benchmark 21:24:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3104.844757762112, 3169.730572901304, 3175.095097897098, 3195.137312925509, 3211.3095684427844, 5608.186812912125, 5697.059985102458, 5698.401667824881, 5718.685472299022, 5720.971395143024, 5671.631343962639, 5744.913826292609, 5749.252597162374, 5752.050911599581, 5754.769809207637, 5145.253938178962, 5205.16717325228, 5208.218767184915, 5227.242049902762, 5267.051930652481, 5017.949820501803, 5253.395859476152, 5273.630845840793, 5278.551323137538, 5300.310959575249, 4986.551210391064, 5121.795128194868, 5156.639035267533, 5159.948400515985, 5162.019216348882, 5191.221316802472, 5205.531502164805, 5278.366596008465, 5279.472052794728, 5300.2049692546425, 5005.199168133081, 5107.9744601277125, 5187.844364669066, 5227.529522343008, 5253.028189784902, 5526.613137080406, 5544.944550554484, 5608.719564021823, 5612.69130197839, 5642.040853054949, 6036.788712395045, 6048.062550304666, 6068.57519973602, 6073.240844894388, 6075.119107729354, 5869.471747542699, 6102.664353460558, 6117.847053823645, 6129.908051379233, 6130.540209484262, 5515.283013208297, 5627.380988091307, 5656.321241451011, 5680.5455563554815, 5759.481646651821, 6263.718132683949, 6271.498280137669, 6276.592021518587, 6279.591826531261, 6284.465820405226, 5992.161097446361, 5999.670018148957, 6016.157737916695, 6016.278046634345, 6017.1275165100815, 5888.205092312483, 5931.4958228550195, 5971.373005834412, 5984.401559843981, 6076.787312444043, 6085.148079268906, 6088.178095956989, 6107.053406721965, 6118.418750218722, 6134.570580059442, 6080.391960803884, 6084.209052823193, 6092.817215483543, 6125.908111378333, 6140.631562106288, 4571.382863313476, 4612.515685852937, 4652.790624421909, 4704.858854234379, 4722.669413141047, 4125.5874412558505, 4167.624913757776, 4173.9582604173565, 4189.601987811153, 4226.556211597799, 5782.335031471434, 5848.590598658138, 5852.180694702745, 5860.238169037998, 5865.677387743715, 5879.353271140171, 6219.813405597839, 6225.750969961241, 6232.065190221412, 6234.1583886175695, 5579.7489112990015, 5743.4256574342235, 5796.536277097822, 5807.419258074243, 5875.706214689249, 5292.338457692788, 5299.5230429261555, 5303.416624171338, 5305.098133317345, 5308.044551980681, 6312.4634406076, 6359.141515895295, 6362.586431881913, 6368.140301059298, 6375.776847810212, 5898.94101058984, 5953.851153721192, 6041.18444010053, 6096.9390306096375, 6106.358832322542, 6252.0, 6264.812055638338, 6308.747650093945, 6314.842128946813, 6319.494440444661, 6075.301340345917, 6075.48112971757, 6077.453029227391, 6078.787242446493, 6082.482988945989, 5827.59206855533, 5954.374790647093, 6074.544409169242, 6091.42131497507, 6142.170806941184, 6013.879722405615, 6047.606905551125, 6059.848503787441, 6061.575689701678, 6098.878022439615, 6027.939720602913, 6031.517478601613, 6031.517478601789, 6034.185384972972, 6034.456898879122, 5750.7987220447085, 5825.0, 5884.529237661062, 6002.699865006645, 6017.0, 5934.050551911673, 6038.879222415615, 6043.063325184604, 6056.273247210363, 6059.33347331802, 5777.566682498746, 5819.0, 5860.531157507304, 5862.530997520103, 5866.090755932837], "value": 5616.969750583531, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.6627522312281, 610.4322979628945, 630.4735545819241, 631.4033238589532, 643.1606753187095, 36806.0, 37325.44011839821, 46096.76951615242, 47146.76426617862, 47179.0, 48598.51401485993, 48876.266855997186, 48944.75527622357, 49073.754631226795, 49199.26201106986, 9285.396449230795, 9449.76375590609, 9452.81094378112, 9457.243420526342, 9467.100625440573, 8263.62813673383, 8472.534010629413, 11005.229633925628, 11260.436978151101, 11266.43667816606, 11302.039326657245, 11388.487518061707, 11399.886001139965, 11400.657980260605, 11415.714607134847, 11185.384803835745, 11197.888021119767, 11267.267627604262, 11275.66173014811, 11282.266652667551, 11023.06303964164, 11086.556537738481, 11089.27919685226, 11091.778164436746, 11098.55605775768, 44597.77701111474, 44619.553804461866, 44684.0, 44912.77543612294, 44949.32576011362, 3856.382978723419, 3887.786171760552, 3970.06703424695, 3978.8408463661417, 4553.4991150973365, 33715.83142084299, 33790.0, 34069.48895766566, 34198.82900585506, 35772.46341304883, 4647.34937108805, 4648.883777905546, 4671.602913752301, 4741.976290118528, 4748.833790817339, 322848.0, 322881.0, 323288.0, 323625.0, 324077.0, 64848.67575662091, 64911.35088649053, 65254.34745652578, 65275.67362163254, 65535.0, 40281.59718402837, 41009.0, 41262.793686031975, 43721.78139109284, 43727.56272437298, 19026.904865475582, 19093.331733389543, 19157.32949346794, 19207.32774352919, 19244.903775481314, 12871.613851584467, 13001.219926804422, 14493.565193044225, 14585.343659535347, 14616.707665846623, 20299.492512687302, 20770.688439673417, 20783.896080519502, 21232.89383553103, 21666.56666866654, 7493.962530187314, 7730.96134519335, 7754.651040703182, 7769.223077692299, 7806.102298235662, 974.4202199691173, 1011.2404416315704, 1069.5989004123298, 1094.5074716377662, 1100.1638754546602, 34521.48217776736, 34540.309193815985, 34664.26678666107, 34719.479207811906, 34831.82584087114, 1177.9941100294443, 1190.494040033, 1211.787937111002, 1230.9076819238594, 1255.6358655989661, 17965.281388744304, 18181.0, 18181.909090454465, 18195.337139207302, 18222.180001899946, 531282.0, 541328.0, 547369.0, 547453.0, 548173.0, 60626.696866516264, 60807.39192608106, 61037.0, 61148.0, 61245.38754612486, 1322.6098301001227, 1324.8675132486674, 1382.7372799168127, 1416.2706206303762, 1416.3626368134176, 31316.843415782776, 34663.306733865684, 34985.65014349926, 35503.82248088743, 35538.64461355354, 52061.7396913013, 52445.47554524406, 52454.21318680299, 52536.73731631317, 52560.73719631377, 399176.0, 399504.0, 400080.0, 400108.0, 400913.0, 27163.320916977234, 27730.86134569314, 29790.404191915608, 30293.848530757205, 30365.240868978453, 48698.26952595643, 48703.5129648699, 48807.511924880295, 49200.0, 50476.49523504718, 41238.58761412468, 42226.155476889675, 42510.92886663092, 43068.35397469103, 43231.78384108059, 42338.788306058275, 42533.787331064384, 42973.570264296955, 43525.78237108794, 43753.0, 42684.78657606692, 43127.35308970431, 43829.780851095544, 44004.33993490164, 44036.11927761363, 35823.64176358307, 36986.44520332251, 37528.92385902425, 37878.8106059468, 37970.34207605552, 28755.562221888402, 28907.566386503797, 28963.710362896945, 29218.7078129216, 29335.85332073326], "value": 21270.620508540414, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.9896752581187, 414.50880706362943, 426.0775421213074, 427.529717310958, 442.63924901205513, 18878.62242755144, 19298.228070877165, 20336.694949575733, 20581.073851676672, 20675.069621867013, 18838.81161188391, 18873.339433119843, 18912.58155638329, 18985.525361865926, 19064.046797660096, 5813.82558523245, 6126.17296664949, 6135.938640613582, 6139.539534534905, 6140.7850725224625, 5844.064949608063, 5973.671448070354, 6013.278406591216, 6101.633901965874, 6109.297430795449, 5997.700114994254, 6001.459868611824, 6002.759889604411, 6009.759609615632, 6016.127661489081, 5894.233749612566, 6002.429769171922, 6003.129546215796, 6087.878242435127, 6123.877522449526, 6005.3394126646035, 6009.1587177795145, 6015.518758499309, 6015.608985415934, 6016.338202797689, 15257.313420895975, 15328.463503777315, 15341.693166136727, 15990.20048997557, 16317.91841040799, 2392.2823153054014, 2439.121916110199, 2457.8402403843693, 2527.064985955208, 2548.2992177151245, 10793.62222322215, 10974.396408197546, 11243.325400475916, 13772.380242889094, 13782.793258101035, 1975.9506012349661, 1992.8804271743597, 2072.471519762466, 2102.096098677568, 2109.4199095248778, 63181.68409157971, 63824.361756382306, 78514.0, 79952.99999999942, 81380.59309703473, 11722.120840936965, 11904.702382440335, 11983.640490785116, 12063.457144428521, 12084.516619335129, 17048.48854534366, 17048.57378565521, 17118.743218851727, 17152.31390744381, 17166.65666686659, 8942.642294308285, 9033.141851524095, 9165.083491650916, 9226.677066302647, 9324.906750932403, 8910.643574257087, 8943.040932184032, 8951.955240223757, 9041.367104302635, 9086.0, 5146.4853514648985, 5223.895522089537, 5257.947420525746, 5261.815836445706, 5367.812126575551, 2004.7393838800863, 2117.5965279407983, 2118.375079351595, 2139.893005349726, 2190.7371115466244, 953.2135987810084, 995.4027583449872, 1078.8867168947147, 1113.2151832957745, 1116.4919961417536, 19619.411417657495, 19918.30285939985, 19920.90039549793, 20090.19639214415, 20256.89871550633, 1091.2961140064615, 1096.5230124895536, 1121.3664279682116, 1122.9157813164045, 1160.825876118572, 10861.402622855661, 11183.608573699881, 11184.161187910939, 11205.215634905479, 11295.830562541569, 483138.0, 486156.751275117, 495794.0, 501386.0, 503100.0, 94511.0, 96554.0, 96853.0, 97183.05633887283, 98447.0, 1036.2953191829629, 1037.901399367059, 1039.9792004159874, 1045.8797238317538, 1076.34343050739, 17291.56771080733, 17651.911740441217, 18151.546211344823, 18283.634327313113, 18426.815731843046, 28729.425411491236, 31435.685643144192, 39329.41005884971, 42416.36375454309, 44717.77641111774, 59443.0, 62136.68931655313, 65742.0, 66308.33691663021, 66781.66609166923, 8381.37139714536, 9443.150116489274, 9456.621735130793, 9563.713088607354, 9576.856347154659, 14126.858731412965, 14175.0, 14180.858191417954, 14696.55910322692, 14885.851141488447, 12008.699782505508, 12159.392030398622, 12314.322712250912, 12353.876461235273, 12429.564965226175, 12213.206141600767, 12308.938455307667, 12372.690682733004, 12506.374681266083, 12844.678883027625, 12320.75358492843, 12383.380830958597, 12453.626391208278, 12697.365131743562, 12876.806847897476, 9170.358074934691, 9233.722988310361, 9287.071292870658, 9598.95200523993, 9693.9030609693, 9849.556769945513, 11561.88438115608, 12092.637220883387, 12307.630771076882, 12529.561465349034], "value": 9638.518821339563, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1527.5799155232307, 1546.7138579362818, 1675.1289329548636, 1792.3905872003515, 1845.8061903500131, 8648.870266945993, 9309.953450232739, 9337.25301975842, 9338.719838404842, 9340.719778406641, 8207.712730054449, 8491.023532293788, 8792.0, 9029.32280078995, 9145.08549145085, 2484.2919767866115, 2496.7877730392847, 2512.5351809915223, 2512.6105453654623, 2517.2070797698757, 2405.56699794037, 2519.3071905226025, 2521.319243804172, 2521.9117330893423, 2524.2805800346905, 2448.7306396296394, 2451.8651474168914, 2522.9495410091786, 2524.179641616473, 2526.68416447944, 2437.744036876129, 2438.231956933569, 2450.987745061281, 2485.478049609584, 2493.47636996231, 2359.3629719975684, 2364.5034542746043, 2368.5144545368157, 2370.988145059281, 2521.697396312436, 9311.115444032806, 9344.345895787297, 9399.765005874908, 9425.38734982224, 9434.05659434058, 5526.253955715967, 5649.604527683064, 5658.830235092953, 5667.291588551431, 5670.6030577859565, 3360.1431634932937, 3403.6426175251736, 3503.6496350365014, 3513.332466831294, 3517.402041652925, 1164.2548768787983, 1185.25921299188, 1210.8365370675021, 1238.0652607281445, 1240.6526172671665, 12370.257784532956, 12416.130870839044, 12429.192102513398, 12477.0, 12477.126601137925, 4767.594754445841, 4786.569208771228, 4799.18413869643, 4901.068796928572, 4981.2030075187795, 10596.417197054081, 10599.682009539572, 10609.363438193734, 10614.0, 10649.84025239622, 5562.02664533705, 5569.582281328835, 5579.191017302468, 5584.329880414376, 5585.1901474286815, 4458.977705111519, 4621.653375996813, 5050.545450909436, 5070.062038522885, 5136.332276804066, 4191.119864828359, 4285.957140428618, 4353.542877997828, 4385.561443855589, 4389.29771236607, 1336.652470357714, 1353.1813252982001, 1358.2393859438746, 1362.7615167345675, 1379.4482207117233, 1031.5718976624767, 1036.6164519127972, 1037.8910214427528, 1041.9114375278034, 1055.889131641182, 6237.688115594293, 6422.42198202164, 6428.19647544057, 6459.935400646027, 6554.770583029571, 1005.6178652112151, 1040.1626690514208, 1045.3988956350129, 1067.8947289555274, 1091.3888222595372, 4164.104717485755, 4316.2446571849805, 4454.26504626733, 4516.254817955067, 4555.612772914273, 11247.100231981422, 11493.42532873353, 11567.42162891852, 11570.652880413601, 11640.592579259684, 10374.481275936172, 11480.196386253048, 11498.827517587242, 11537.711557211136, 11541.134414918915, 8435.831283374298, 8721.694740684046, 8726.301895848444, 8733.956330218309, 8739.43193692408, 6395.688883778907, 6416.550841441241, 6478.287388387368, 6622.337766223339, 6715.56348837324, 10622.415767132881, 10672.359658420519, 10682.412467314372, 10793.244472886823, 10805.729856753329, 10226.846597301195, 10686.145108391465, 10694.679159625224, 10907.672769816918, 11026.173037022416, 7412.62936853166, 7654.0, 8277.58612069406, 8461.703840365557, 8467.0, 8691.087435819401, 8872.689455869013, 9060.093990600888, 9095.909040909772, 9101.499417532099, 7885.6451459685595, 7912.762617121495, 7919.12889582134, 7954.443188976716, 8007.359411247203, 7639.656215470206, 7666.425018123551, 7890.408219383455, 7908.8813667793875, 8010.158933312151, 7309.122905251404, 7357.889631655423, 7408.851822963403, 7428.554286742813, 7462.291082347168, 5320.122179840438, 5342.973285133705, 5373.0, 5439.646422982493, 5446.264754258124, 5578.525825304732, 5603.495685388335, 5635.971820140873, 5647.1529270609735, 5832.50423713989], "value": 4906.254323923606, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.43531044397633, 353.09403608303654, 357.6888107346609, 360.02433405471186, 361.54625944439726, 5501.174823776436, 5570.777168913243, 5574.777008919648, 5599.524040456561, 5649.689267090308, 5502.422245664207, 5538.3692745945655, 5545.639533430324, 5558.499735023847, 5575.219469274305, 3769.886903392889, 4107.322291821846, 4236.195122926634, 4314.417553630266, 4320.891977700551, 4304.698671093025, 4308.289132293168, 4311.116221174668, 4331.631811296043, 4331.935020974688, 4255.446791917062, 4310.97844510777, 4320.265554855682, 4321.589449002356, 4331.740095594275, 4245.469316335458, 4291.54938731435, 4303.612674859246, 4317.43873296471, 4329.653627709776, 3857.1514266861245, 3858.9228215435814, 3864.091938394475, 3865.2269546090893, 3895.883123506271, 5282.947170528322, 5369.382521010095, 5404.081306177959, 5421.241026256327, 5449.591280653927, 4826.300186472977, 4963.0, 4995.700257984533, 5030.245463180516, 5060.443351231362, 5728.2242504823635, 5729.627574207663, 5745.339285982123, 5745.454181852718, 5748.655080695172, 4262.680298977558, 4266.911937455929, 4273.893152671208, 4276.444062271916, 4279.679024073207, 5734.483896449298, 5914.733836977303, 5920.733566989496, 6008.699565021775, 6012.939870601282, 4322.530339684522, 4323.2434323993175, 4328.956710432918, 4336.522982471925, 4339.240632889295, 4416.602505774432, 4423.845165419195, 4436.511983681792, 4441.977790111029, 4459.531749166355, 4678.555537223959, 4919.704817710949, 4976.875578110504, 4980.203167493184, 5005.224190250517, 5761.049426844607, 5761.9135712964335, 5776.451237132465, 5780.68772491007, 5849.766009359663, 1482.7849961755485, 1510.6601014771588, 1515.4014164404998, 1519.7188520123811, 1525.6948610277766, 913.8400779863497, 962.5908988679784, 962.6341990043878, 963.6193703487083, 981.2444417798256, 4928.728919909439, 4931.58081563064, 4936.580390666833, 4956.274049272885, 4962.578180854595, 5173.456787037382, 5173.948260517422, 5178.171492561172, 5199.246109314128, 5218.478152184827, 4651.395318608559, 4871.585915197177, 4916.5004673574185, 4926.0, 4927.852164435073, 2768.9030883918967, 2781.3463835998523, 2781.374190807093, 2798.726579406365, 2802.5936239245193, 5281.656692314988, 5302.3637163540625, 5311.654742441729, 5328.6802791832615, 5347.491988261109, 5243.606729495303, 5288.334174734946, 5711.400302968129, 5825.825225243249, 6130.693465326716, 5999.820005399845, 6006.0, 6114.868749281308, 6126.693665316806, 6136.938630613726, 5994.67029313392, 6018.0, 6022.698865056817, 6073.726682299219, 6113.969430152821, 5607.971960140173, 5861.824145275648, 5911.467967882739, 5924.407559244041, 5940.0, 6151.507879369729, 6167.753289868535, 6182.536309776695, 6192.411720886508, 6224.844378890382, 4091.89770255746, 4354.063876266618, 4364.7162934410435, 4366.388705581157, 4387.091615147421, 5843.853903652443, 5891.617044892068, 5930.487725629937, 5935.584509084322, 5943.673097979479, 5784.5083167929515, 5793.449622285876, 5814.418558144321, 5858.765649373977, 5868.4424979626865, 5596.524295434933, 5755.251817263729, 5762.337331206797, 5764.164196191613, 5767.077267637158, 5749.281339832521, 5767.423257674199, 5769.336526299361, 5779.508741756829, 5786.537077033743, 5614.9719251403485, 5800.839832033525, 5804.709764511842, 5807.593468457168, 5829.679367634821, 5645.802396916089, 5666.235058267246, 5697.800576979786, 5707.400722924033, 5718.8570285741525], "value": 4350.015637285455, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.9725259615915, 835.5655059369128, 873.580681272989, 878.477306002928, 908.3913777768894, 14519.20144392058, 15304.69390612187, 15413.460528881491, 15455.922720386396, 15464.149471779061, 14510.347034383452, 15227.695446091071, 15939.681206375866, 16092.356305747786, 16115.355385784555, 825.3892119831312, 871.1201686296854, 877.4822854515835, 884.0496466298722, 884.460479107747, 735.698363670895, 751.9511231769917, 871.0984131423977, 882.7175303902753, 895.3687650206589, 941.1247539787994, 942.7030485397112, 943.6131186213654, 944.0, 944.2681921510849, 929.5166513413055, 935.5883411299006, 935.672514619881, 936.063936063936, 936.8220038192721, 692.3526502719973, 692.9792106236821, 693.1370443797454, 693.2893783871572, 693.3309356471029, 15502.0, 15510.750941113589, 15559.766603500957, 15561.066336019761, 15594.064356138668, 15331.310091045929, 16444.34222631093, 16493.609026313345, 16922.323107075703, 16998.235079421454, 13133.86866131336, 13249.0, 13275.402606882617, 13394.330283485786, 13599.0, 4158.272302347077, 4169.353750168729, 4215.894602634959, 4241.27898257297, 4300.462442194726, 73311.63344183245, 75789.0, 77326.61336693281, 83855.16144838596, 85666.0, 11644.941775291069, 12034.217775844541, 12216.26702397859, 12618.81071783924, 12881.484740610458, 21990.89004554967, 22059.779402206095, 22086.447838803837, 22095.0, 22111.0, 9615.326927115175, 9675.177609903238, 9718.173955213744, 9750.902490974999, 9831.852522212173, 5079.08576456234, 5229.111051121318, 5265.52610265078, 5305.8938821223355, 5353.330833645794, 3908.785016824102, 4081.6530594899173, 4083.5099788025627, 4083.97958010214, 4120.423140760296, 664.4916638771343, 677.376813331736, 685.3934268172703, 704.8167476456158, 707.6178863413699, 674.0024763350269, 686.0224180542806, 723.2767232767233, 769.7113582406597, 816.4529765057425, 10093.0, 10310.793784124275, 10578.10086142671, 10826.133909287239, 11417.143714221467, 735.8270806360501, 766.0964942866474, 772.7527191298731, 789.5460110436522, 798.4291231769313, 4984.177610694195, 5395.325584301962, 5414.783408663609, 5430.131179011419, 5433.646812957145, 118322.0, 121739.0, 121881.0, 124070.37964810118, 124540.37729811293, 110120.4493977525, 110327.0, 110473.44763276292, 111751.0, 112778.0, 91964.0, 95500.52249738846, 97248.0, 98345.0, 98766.99999999856, 10136.44249566281, 10155.796884062129, 10213.846792297973, 10326.173906087344, 10462.68611941643, 57858.0, 58593.12110318263, 58963.705181473815, 59493.70253148706, 62242.377576223655, 75802.0, 82079.0, 86315.1368486307, 88355.0, 88960.0, 12501.374931253218, 12918.289494077915, 13235.80146297787, 13293.20240785556, 13363.799543006668, 14723.411063557338, 14806.925965370105, 14820.184889831164, 14874.107553546823, 15453.150076745887, 14319.0, 14600.415983360546, 15181.316840742415, 15235.3905843765, 15365.0, 13880.583582492542, 14107.576772696835, 14215.786763198354, 14253.50112746049, 14985.250737462866, 12096.637100886988, 14098.859011409755, 14207.934404919466, 14307.35616897263, 14857.851421486079, 11263.268377693139, 12236.938815305866, 12405.503779848705, 12465.626031219077, 13362.064655474023, 12045.81931271014, 12540.372981351078, 12750.892502975084, 12919.870801291867, 12959.963202943552], "value": 8194.85534613402, "unit": "score"}], "name": "dromaeo_css", "value": 7656.314251080966, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 111.0, 110.0, 111.0, 112.0, 111.0, 112.0, 109.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 117.0, 122.0, 154.0, 121.0, 122.0, 116.0, 120.0, 149.0, 123.0], "value": 129.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 161.0, 160.0, 161.0, 162.0, 162.0, 161.0, 163.0, 163.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 105.0, 76.0, 76.0, 76.0, 76.0, 107.0, 75.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 116.0, 83.0, 84.0, 82.0, 105.0, 82.0, 83.0, 109.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 147.0, 145.0, 148.0, 146.0, 148.0, 147.0, 147.0, 148.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 94.0, 96.0, 95.0, 94.0, 95.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 49.0, 50.0, 50.0, 49.0, 52.0, 50.0, 49.0, 50.0, 49.0], "value": 49.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 59.0, 60.0, 58.0, 59.0, 59.0, 59.0, 60.0, 58.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 74.0, 74.0, 74.0, 73.0, 74.0, 81.0, 74.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 124.0, 130.0, 127.0, 123.0, 138.0, 132.0, 121.0, 170.0, 123.0], "value": 131.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 160.0, 155.0, 157.0, 157.0, 158.0, 155.0, 155.0, 155.0, 155.0], "value": 156.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 62.0, 62.0, 63.0, 62.0, 65.0, 61.0, 62.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1467.9, "alertThreshold": 2.0}]} 21:24:21 INFO - Return code: 0 21:24:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:24:21 INFO - # TBPL SUCCESS # 21:24:21 INFO - Running post-action listener: _resource_record_post_action 21:24:21 INFO - [mozharness: 2016-12-01 05:24:21.769369Z] Finished run-tests step (success) 21:24:21 INFO - Running post-run listener: _resource_record_post_run 21:24:21 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 329572352; Read time: 0; Write time: 196720 21:24:21 INFO - TinderboxPrint: CPU usage
13.0% 21:24:21 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 21:24:21 INFO - TinderboxPrint: I/O write bytes / time
329,572,352 / 196,720 21:24:21 INFO - TinderboxPrint: CPU idle
8,246.3 (87.0%) 21:24:21 INFO - TinderboxPrint: CPU user
1,184.9 (12.5%) 21:24:21 INFO - TinderboxPrint: Swap in / out
0 / 0 21:24:21 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 111783936; Read time: 0; Write time: 79460 21:24:21 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 217788416; Read time: 0; Write time: 117260 21:24:22 INFO - Running post-run listener: _upload_blobber_files 21:24:22 INFO - Blob upload gear active. 21:24:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:24:22 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 21:24:22 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:24:22 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:24:22 INFO - (blobuploader) - INFO - Open directory for files ... 21:24:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:24:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:24:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:24:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:24:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:24:26 INFO - (blobuploader) - INFO - Done attempting. 21:24:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:24:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:24:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:24:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:24:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:24:27 INFO - (blobuploader) - INFO - Done attempting. 21:24:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:24:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:24:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:24:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:24:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:24:27 INFO - (blobuploader) - INFO - Done attempting. 21:24:27 INFO - (blobuploader) - INFO - Iteration through files over. 21:24:27 INFO - Return code: 0 21:24:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:24:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:24:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c0647f289e0b29f6f8f14ceece81023a14486d0c8d82149e9a4833260c33ded8e2b1feb94fda0761a811592225d9a37554693e2cdd9be10714d3c5ab93a1029d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bc1e7298d041e74b7b6cc6de5f4d0458bfc1540edf029f02138977ad1df2c25ee32d56ac017c5229dab8ecc39804ef7b7c406704db6cc48790c4531dba5be0fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6865028d7653794d3e9ebade9d035772ca543bb0c2b941e663ad84d4cdf19eaa91d8fe40512329b528e6d1f73b12449bb0fb68f82b12436e2163d9a38fbe02c3"} 21:24:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:24:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:24:27 INFO - Contents: 21:24:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c0647f289e0b29f6f8f14ceece81023a14486d0c8d82149e9a4833260c33ded8e2b1feb94fda0761a811592225d9a37554693e2cdd9be10714d3c5ab93a1029d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bc1e7298d041e74b7b6cc6de5f4d0458bfc1540edf029f02138977ad1df2c25ee32d56ac017c5229dab8ecc39804ef7b7c406704db6cc48790c4531dba5be0fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6865028d7653794d3e9ebade9d035772ca543bb0c2b941e663ad84d4cdf19eaa91d8fe40512329b528e6d1f73b12449bb0fb68f82b12436e2163d9a38fbe02c3"} 21:24:27 INFO - Running post-run listener: copy_logs_to_upload_dir 21:24:27 INFO - Copying logs to upload dir... 21:24:27 INFO - mkdir: /builds/slave/test/build/upload/logs 21:24:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.552332 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-11-30 21:24:26.684966) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 21:24:26.693568) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1480566404.276316-1892045505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c0647f289e0b29f6f8f14ceece81023a14486d0c8d82149e9a4833260c33ded8e2b1feb94fda0761a811592225d9a37554693e2cdd9be10714d3c5ab93a1029d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bc1e7298d041e74b7b6cc6de5f4d0458bfc1540edf029f02138977ad1df2c25ee32d56ac017c5229dab8ecc39804ef7b7c406704db6cc48790c4531dba5be0fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6865028d7653794d3e9ebade9d035772ca543bb0c2b941e663ad84d4cdf19eaa91d8fe40512329b528e6d1f73b12449bb0fb68f82b12436e2163d9a38fbe02c3"} build_url:https://queue.taskcluster.net/v1/task/KHWzPn8aRuWqCFdxt2NrPQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011439 build_url: 'https://queue.taskcluster.net/v1/task/KHWzPn8aRuWqCFdxt2NrPQ/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c0647f289e0b29f6f8f14ceece81023a14486d0c8d82149e9a4833260c33ded8e2b1feb94fda0761a811592225d9a37554693e2cdd9be10714d3c5ab93a1029d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bc1e7298d041e74b7b6cc6de5f4d0458bfc1540edf029f02138977ad1df2c25ee32d56ac017c5229dab8ecc39804ef7b7c406704db6cc48790c4531dba5be0fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6865028d7653794d3e9ebade9d035772ca543bb0c2b941e663ad84d4cdf19eaa91d8fe40512329b528e6d1f73b12449bb0fb68f82b12436e2163d9a38fbe02c3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 21:24:26.719069) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 21:24:26.719416) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1480566404.276316-1892045505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 21:24:26.801085) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 21:24:26.804445) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 21:24:26.804748) ========= ========= Total master_lag: 0.15 =========