builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1474919888.31 results: success (0) buildid: 20160926094950 builduid: cdcb1c187ecf4b03af49c5f43b43bf07 revision: 82908a457460732127a3790a75ba56459792cec7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 12:58:08.307343) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 12:58:08.308085) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 12:58:08.308627) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 12:58:08.399391) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 12:58:08.399927) ========= 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=836cfdc75598d54cb747368e000001a9-1474915833.129190-622452387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-26 12:58:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-09-26 12:58:09 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116525 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 12:58:08.550712) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 12:58:08.551187) ========= 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=836cfdc75598d54cb747368e000001a9-1474915833.129190-622452387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017599 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 12:58:08.601303) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 12:58:08.601638) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 82908a457460732127a3790a75ba56459792cec7 --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-aurora --rev 82908a457460732127a3790a75ba56459792cec7 --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=836cfdc75598d54cb747368e000001a9-1474915833.129190-622452387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-26 12:58:09,962 truncating revision to first 12 chars 2016-09-26 12:58:09,962 Setting DEBUG logging. 2016-09-26 12:58:09,962 attempt 1/10 2016-09-26 12:58:09,962 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/82908a457460?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-26 12:58:10,338 unpacking tar archive at: mozilla-aurora-82908a457460/testing/mozharness/ program finished with exit code 0 elapsedTime=0.701325 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 12:58:09.316227) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 12:58:09.316540) ========= script_repo_revision: 82908a457460732127a3790a75ba56459792cec7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 12:58:09.316955) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 12:58:09.317245) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 12:58:09.330158) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-09-26 12:58:09.330461) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=836cfdc75598d54cb747368e000001a9-1474915833.129190-622452387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:58:10 INFO - MultiFileLogger online at 20160926 12:58:10 in /builds/slave/test 12:58:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 12:58:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:58:10 INFO - {'append_to_log': False, 12:58:10 INFO - 'base_work_dir': '/builds/slave/test', 12:58:10 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:58:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:58:10 INFO - 'branch': 'Mozilla-Aurora', 12:58:10 INFO - 'buildbot_json_path': 'buildprops.json', 12:58:10 INFO - 'config_files': ('talos/linux_config.py',), 12:58:10 INFO - 'default_actions': ('clobber', 12:58:10 INFO - 'read-buildbot-config', 12:58:10 INFO - 'download-and-extract', 12:58:10 INFO - 'populate-webroot', 12:58:10 INFO - 'create-virtualenv', 12:58:10 INFO - 'install', 12:58:10 INFO - 'run-tests'), 12:58:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:58:10 INFO - 'download_minidump_stackwalk': True, 12:58:10 INFO - 'download_symbols': 'ondemand', 12:58:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:58:10 INFO - 'tooltool.py': '/tools/tooltool.py', 12:58:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:58:10 INFO - '/tools/misc-python/virtualenv.py')}, 12:58:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:58:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:58:10 INFO - 'installer_path': 'installer.exe', 12:58:10 INFO - 'log_level': 'info', 12:58:10 INFO - 'log_name': 'talos', 12:58:10 INFO - 'log_to_console': True, 12:58:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:58:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:58:10 INFO - 'opt_config_files': (), 12:58:10 INFO - 'pip_index': False, 12:58:10 INFO - 'sps_profile': False, 12:58:10 INFO - 'sps_profile_interval': 0, 12:58:10 INFO - 'suite': 'dromaeojs', 12:58:10 INFO - 'system_bits': '32', 12:58:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:58:10 INFO - 'title': 'talos-linux64-ix-028', 12:58:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:58:10 INFO - 'use_talos_json': True, 12:58:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:58:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:58:10 INFO - 'work_dir': 'build'} 12:58:10 INFO - [mozharness: 2016-09-26 19:58:10.791455Z] Running clobber step. 12:58:10 INFO - Running pre-action listener: _resource_record_pre_action 12:58:10 INFO - Running main action method: clobber 12:58:10 INFO - rmtree: /builds/slave/test/build 12:58:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:58:11 INFO - Running post-action listener: _resource_record_post_action 12:58:11 INFO - [mozharness: 2016-09-26 19:58:11.249619Z] Finished clobber step (success) 12:58:11 INFO - [mozharness: 2016-09-26 19:58:11.249719Z] Running read-buildbot-config step. 12:58:11 INFO - Running pre-action listener: _resource_record_pre_action 12:58:11 INFO - Running main action method: read_buildbot_config 12:58:11 INFO - Using buildbot properties: 12:58:11 INFO - { 12:58:11 INFO - "project": "", 12:58:11 INFO - "product": "firefox", 12:58:11 INFO - "script_repo_revision": "production", 12:58:11 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 12:58:11 INFO - "repository": "", 12:58:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 12:58:11 INFO - "buildid": "20160926094950", 12:58:11 INFO - "pgo_build": "True", 12:58:11 INFO - "basedir": "/builds/slave/test", 12:58:11 INFO - "buildnumber": 532, 12:58:11 INFO - "slavename": "talos-linux64-ix-028", 12:58:11 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:58:11 INFO - "platform": "ubuntu64_hw", 12:58:11 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 12:58:11 INFO - "branch": "mozilla-aurora", 12:58:11 INFO - "repo_path": "releases/mozilla-aurora", 12:58:11 INFO - "revision": "82908a457460732127a3790a75ba56459792cec7", 12:58:11 INFO - "stage_platform": "linux64-pgo", 12:58:11 INFO - "builduid": "cdcb1c187ecf4b03af49c5f43b43bf07", 12:58:11 INFO - "slavebuilddir": "test" 12:58:11 INFO - } 12:58:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/e-zwRMXWRUauU4vu4aLIXA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 12:58:11 INFO - Running post-action listener: _resource_record_post_action 12:58:11 INFO - [mozharness: 2016-09-26 19:58:11.252154Z] Finished read-buildbot-config step (success) 12:58:11 INFO - [mozharness: 2016-09-26 19:58:11.252242Z] Running download-and-extract step. 12:58:11 INFO - Running pre-action listener: _resource_record_pre_action 12:58:11 INFO - Running main action method: download_and_extract 12:58:11 INFO - mkdir: /builds/slave/test/build/tests 12:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:11 INFO - trying https://queue.taskcluster.net/v1/task/e-zwRMXWRUauU4vu4aLIXA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 12:58:11 INFO - Downloading https://queue.taskcluster.net/v1/task/e-zwRMXWRUauU4vu4aLIXA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 12:58:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e-zwRMXWRUauU4vu4aLIXA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:58:11 INFO - Downloaded 1361 bytes. 12:58:11 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 12:58:11 INFO - Using the following test package requirements: 12:58:11 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 12:58:11 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:58:11 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 12:58:11 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:58:11 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 12:58:11 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:58:11 INFO - u'jsshell-linux-x86_64.zip'], 12:58:11 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:58:11 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 12:58:11 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 12:58:11 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:58:11 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 12:58:11 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:58:11 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 12:58:11 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:58:11 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 12:58:11 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:58:11 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 12:58:11 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:58:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e-zwRMXWRUauU4vu4aLIXA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 12:58:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e-zwRMXWRUauU4vu4aLIXA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:58:11 INFO - Fetch https://queue.taskcluster.net/v1/task/e-zwRMXWRUauU4vu4aLIXA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 12:58:12 INFO - Expected file size: 21898479 12:58:16 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:58:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e-zwRMXWRUauU4vu4aLIXA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 12:58:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e-zwRMXWRUauU4vu4aLIXA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:58:16 INFO - Fetch https://queue.taskcluster.net/v1/task/e-zwRMXWRUauU4vu4aLIXA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 12:58:17 INFO - Expected file size: 21898479 12:58:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e-zwRMXWRUauU4vu4aLIXA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 12:58:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e-zwRMXWRUauU4vu4aLIXA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:58:22 INFO - Fetch https://queue.taskcluster.net/v1/task/e-zwRMXWRUauU4vu4aLIXA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 12:58:22 INFO - Expected file size: 14414059 12:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:23 INFO - trying https://queue.taskcluster.net/v1/task/e-zwRMXWRUauU4vu4aLIXA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 12:58:23 INFO - Downloading https://queue.taskcluster.net/v1/task/e-zwRMXWRUauU4vu4aLIXA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 12:58:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e-zwRMXWRUauU4vu4aLIXA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:58:24 INFO - Downloaded 63961579 bytes. 12:58:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e-zwRMXWRUauU4vu4aLIXA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 12:58:24 INFO - mkdir: /builds/slave/test/properties 12:58:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:58:24 INFO - Writing to file /builds/slave/test/properties/build_url 12:58:24 INFO - Contents: 12:58:24 INFO - build_url:https://queue.taskcluster.net/v1/task/e-zwRMXWRUauU4vu4aLIXA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 12:58:24 INFO - Running post-action listener: _resource_record_post_action 12:58:24 INFO - Running post-action listener: set_extra_try_arguments 12:58:24 INFO - [mozharness: 2016-09-26 19:58:24.818840Z] Finished download-and-extract step (success) 12:58:24 INFO - [mozharness: 2016-09-26 19:58:24.819140Z] Running populate-webroot step. 12:58:24 INFO - Running pre-action listener: _resource_record_pre_action 12:58:24 INFO - Running main action method: populate_webroot 12:58:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:58:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:58:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:58:24 INFO - '--tppagecycles', 12:58:24 INFO - '7'], 12:58:24 INFO - 'tests': ['tsvgm']}}, 12:58:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:58:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:58:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:58:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:58:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:58:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:58:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:24 INFO - 'talos_options': ['--disable-e10s'], 12:58:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:58:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:58:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:24 INFO - 'talos_options': ['--disable-e10s'], 12:58:24 INFO - 'tests': ['damp', 'tps']}, 12:58:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:24 INFO - 'tests': ['damp', 'tps']}, 12:58:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:58:24 INFO - 'tests': ['dromaeo_dom']}, 12:58:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:58:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:58:24 INFO - 'tests': ['basic_compositor_video']}, 12:58:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:58:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:58:24 INFO - 'tests': ['a11yr', 12:58:24 INFO - 'ts_paint', 12:58:24 INFO - 'tpaint', 12:58:24 INFO - 'sessionrestore', 12:58:24 INFO - 'sessionrestore_no_auto_restore', 12:58:24 INFO - 'tabpaint']}, 12:58:24 INFO - 'other-e10s': {'tests': ['a11yr', 12:58:24 INFO - 'ts_paint', 12:58:24 INFO - 'tpaint', 12:58:24 INFO - 'sessionrestore', 12:58:24 INFO - 'sessionrestore_no_auto_restore', 12:58:24 INFO - 'tabpaint']}, 12:58:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:58:24 INFO - 'ts_paint', 12:58:24 INFO - 'tpaint', 12:58:24 INFO - 'sessionrestore', 12:58:24 INFO - 'sessionrestore_no_auto_restore', 12:58:24 INFO - 'tabpaint']}, 12:58:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:58:24 INFO - 'ts_paint', 12:58:24 INFO - 'tpaint', 12:58:24 INFO - 'sessionrestore', 12:58:24 INFO - 'sessionrestore_no_auto_restore', 12:58:24 INFO - 'tabpaint']}, 12:58:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:58:24 INFO - 'tests': ['a11yr', 12:58:24 INFO - 'ts_paint', 12:58:24 INFO - 'tpaint', 12:58:24 INFO - 'sessionrestore', 12:58:24 INFO - 'sessionrestore_no_auto_restore', 12:58:24 INFO - 'tabpaint']}, 12:58:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:58:24 INFO - 'tests': ['a11yr', 12:58:24 INFO - 'ts_paint', 12:58:24 INFO - 'tpaint', 12:58:24 INFO - 'sessionrestore', 12:58:24 INFO - 'sessionrestore_no_auto_restore', 12:58:24 INFO - 'tabpaint']}, 12:58:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:58:24 INFO - 'tests': ['tsvgx', 12:58:24 INFO - 'tsvgr_opacity', 12:58:24 INFO - 'tart', 12:58:24 INFO - 'tscrollx', 12:58:24 INFO - 'cart']}, 12:58:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:58:24 INFO - 'tsvgr_opacity', 12:58:24 INFO - 'tart', 12:58:24 INFO - 'tscrollx', 12:58:24 INFO - 'cart']}, 12:58:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:24 INFO - 'talos_options': ['--disable-e10s'], 12:58:24 INFO - 'tests': ['tp5o']}, 12:58:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:24 INFO - 'tests': ['tp5o']}, 12:58:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:24 INFO - 'talos_options': ['--disable-e10s', 12:58:24 INFO - '--xperf_path', 12:58:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:58:24 INFO - 'tests': ['tp5n']}, 12:58:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:24 INFO - 'talos_options': ['--xperf_path', 12:58:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:58:24 INFO - 'tests': ['tp5n']}}, 12:58:24 INFO - 'talos.zip': {'path': '', 12:58:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:58:24 INFO - Running post-action listener: _resource_record_post_action 12:58:24 INFO - [mozharness: 2016-09-26 19:58:24.840750Z] Finished populate-webroot step (success) 12:58:24 INFO - [mozharness: 2016-09-26 19:58:24.840843Z] Running create-virtualenv step. 12:58:24 INFO - Running pre-action listener: _resource_record_pre_action 12:58:24 INFO - Running main action method: create_virtualenv 12:58:24 INFO - Creating virtualenv /builds/slave/test/build/venv 12:58:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:58:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:58:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:58:24 INFO - Using real prefix '/usr' 12:58:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:58:25 INFO - Installing distribute.............................................................................................................................................................................................done. 12:58:27 INFO - Installing pip.................done. 12:58:27 INFO - Return code: 0 12:58:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:58: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')]} 12:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58: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')]} 12:58:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f265e23cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1387ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1384f60>, '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 0x1385d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13861d0>, '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': '836cfdc75598d54cb747368e000001a9-1474915833.129190-622452387', '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 12:58:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:58:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:58:27 INFO - Using env: {'DISPLAY': ':0', 12:58:27 INFO - 'HOME': '/home/cltbld', 12:58:27 INFO - 'LANG': 'en_US.UTF-8', 12:58:27 INFO - 'LANGUAGE': 'en_US:en', 12:58:27 INFO - 'LOGNAME': 'cltbld', 12:58:27 INFO - 'MAIL': '/var/mail/cltbld', 12:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:27 INFO - 'MOZ_NO_REMOTE': '1', 12:58:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:27 INFO - 'NO_EM_RESTART': '1', 12:58:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:27 INFO - 'PWD': '/builds/slave/test', 12:58:27 INFO - 'SHELL': '/bin/bash', 12:58:27 INFO - 'SHLVL': '1', 12:58:27 INFO - 'TERM': 'linux', 12:58:27 INFO - 'TMOUT': '86400', 12:58:27 INFO - 'USER': 'cltbld', 12:58:27 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474915833.129190-622452387', 12:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:27 INFO - '_': '/tools/buildbot/bin/python'} 12:58:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:58:27 INFO - Cleaning up... 12:58:27 INFO - Return code: 0 12:58:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:58: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')]} 12:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58: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')]} 12:58:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f265e23cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1387ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1384f60>, '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 0x1385d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13861d0>, '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': '836cfdc75598d54cb747368e000001a9-1474915833.129190-622452387', '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 12:58:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:58:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:58:27 INFO - Using env: {'DISPLAY': ':0', 12:58:27 INFO - 'HOME': '/home/cltbld', 12:58:27 INFO - 'LANG': 'en_US.UTF-8', 12:58:27 INFO - 'LANGUAGE': 'en_US:en', 12:58:27 INFO - 'LOGNAME': 'cltbld', 12:58:27 INFO - 'MAIL': '/var/mail/cltbld', 12:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:27 INFO - 'MOZ_NO_REMOTE': '1', 12:58:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:27 INFO - 'NO_EM_RESTART': '1', 12:58:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:27 INFO - 'PWD': '/builds/slave/test', 12:58:27 INFO - 'SHELL': '/bin/bash', 12:58:27 INFO - 'SHLVL': '1', 12:58:27 INFO - 'TERM': 'linux', 12:58:27 INFO - 'TMOUT': '86400', 12:58:27 INFO - 'USER': 'cltbld', 12:58:27 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474915833.129190-622452387', 12:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:27 INFO - '_': '/tools/buildbot/bin/python'} 12:58:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:27 INFO - Downloading/unpacking psutil>=3.1.1 12:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:58:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:58:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:58:29 INFO - Installing collected packages: psutil 12:58:29 INFO - Running setup.py install for psutil 12:58:29 INFO - building 'psutil._psutil_linux' extension 12:58:29 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 12:58:30 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 12:58:30 INFO - building 'psutil._psutil_posix' extension 12:58:30 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 12:58:30 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 12:58:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:58:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:58:30 INFO - Successfully installed psutil 12:58:30 INFO - Cleaning up... 12:58:30 INFO - Return code: 0 12:58:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f265e23cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1387ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1384f60>, '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 0x1385d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13861d0>, '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': '836cfdc75598d54cb747368e000001a9-1474915833.129190-622452387', '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 12:58:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:58:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:58:30 INFO - Using env: {'DISPLAY': ':0', 12:58:30 INFO - 'HOME': '/home/cltbld', 12:58:30 INFO - 'LANG': 'en_US.UTF-8', 12:58:30 INFO - 'LANGUAGE': 'en_US:en', 12:58:30 INFO - 'LOGNAME': 'cltbld', 12:58:30 INFO - 'MAIL': '/var/mail/cltbld', 12:58:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:30 INFO - 'MOZ_NO_REMOTE': '1', 12:58:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:30 INFO - 'NO_EM_RESTART': '1', 12:58:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:30 INFO - 'PWD': '/builds/slave/test', 12:58:30 INFO - 'SHELL': '/bin/bash', 12:58:30 INFO - 'SHLVL': '1', 12:58:30 INFO - 'TERM': 'linux', 12:58:30 INFO - 'TMOUT': '86400', 12:58:30 INFO - 'USER': 'cltbld', 12:58:30 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474915833.129190-622452387', 12:58:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:30 INFO - '_': '/tools/buildbot/bin/python'} 12:58:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:58:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:58:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:58:32 INFO - Installing collected packages: mozsystemmonitor 12:58:32 INFO - Running setup.py install for mozsystemmonitor 12:58:32 INFO - Successfully installed mozsystemmonitor 12:58:32 INFO - Cleaning up... 12:58:32 INFO - Return code: 0 12:58:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:32 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 0x7f265e23cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1387ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1384f60>, '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 0x1385d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13861d0>, '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': '836cfdc75598d54cb747368e000001a9-1474915833.129190-622452387', '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 12:58:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:58:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:58:32 INFO - Using env: {'DISPLAY': ':0', 12:58:32 INFO - 'HOME': '/home/cltbld', 12:58:32 INFO - 'LANG': 'en_US.UTF-8', 12:58:32 INFO - 'LANGUAGE': 'en_US:en', 12:58:32 INFO - 'LOGNAME': 'cltbld', 12:58:32 INFO - 'MAIL': '/var/mail/cltbld', 12:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:32 INFO - 'MOZ_NO_REMOTE': '1', 12:58:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:32 INFO - 'NO_EM_RESTART': '1', 12:58:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:32 INFO - 'PWD': '/builds/slave/test', 12:58:32 INFO - 'SHELL': '/bin/bash', 12:58:32 INFO - 'SHLVL': '1', 12:58:32 INFO - 'TERM': 'linux', 12:58:32 INFO - 'TMOUT': '86400', 12:58:32 INFO - 'USER': 'cltbld', 12:58:32 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474915833.129190-622452387', 12:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:32 INFO - '_': '/tools/buildbot/bin/python'} 12:58:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:32 INFO - Downloading/unpacking jsonschema==2.5.1 12:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:58:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:35 INFO - Downloading functools32-3.2.3-2.tar.gz 12:58:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:58:35 INFO - warning: no files found matching '*.txt' 12:58:35 INFO - no previously-included directories found matching 'build' 12:58:35 INFO - no previously-included directories found matching 'dist' 12:58:35 INFO - no previously-included directories found matching '.git*' 12:58:35 INFO - Installing collected packages: jsonschema, functools32 12:58:35 INFO - Running setup.py install for functools32 12:58:35 INFO - warning: no files found matching '*.txt' 12:58:35 INFO - no previously-included directories found matching 'build' 12:58:35 INFO - no previously-included directories found matching 'dist' 12:58:35 INFO - no previously-included directories found matching '.git*' 12:58:35 INFO - Successfully installed jsonschema functools32 12:58:35 INFO - Cleaning up... 12:58:35 INFO - Return code: 0 12:58:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f265e23cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1387ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1384f60>, '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 0x1385d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13861d0>, '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': '836cfdc75598d54cb747368e000001a9-1474915833.129190-622452387', '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 12:58:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:58:35 INFO - Using env: {'DISPLAY': ':0', 12:58:35 INFO - 'HOME': '/home/cltbld', 12:58:35 INFO - 'LANG': 'en_US.UTF-8', 12:58:35 INFO - 'LANGUAGE': 'en_US:en', 12:58:35 INFO - 'LOGNAME': 'cltbld', 12:58:35 INFO - 'MAIL': '/var/mail/cltbld', 12:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:35 INFO - 'MOZ_NO_REMOTE': '1', 12:58:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:35 INFO - 'NO_EM_RESTART': '1', 12:58:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:35 INFO - 'PWD': '/builds/slave/test', 12:58:35 INFO - 'SHELL': '/bin/bash', 12:58:35 INFO - 'SHLVL': '1', 12:58:35 INFO - 'TERM': 'linux', 12:58:35 INFO - 'TMOUT': '86400', 12:58:35 INFO - 'USER': 'cltbld', 12:58:35 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474915833.129190-622452387', 12:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:35 INFO - '_': '/tools/buildbot/bin/python'} 12:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:58:35 INFO - Cleaning up... 12:58:35 INFO - Return code: 0 12:58:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f265e23cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1387ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1384f60>, '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 0x1385d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13861d0>, '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': '836cfdc75598d54cb747368e000001a9-1474915833.129190-622452387', '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 12:58:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:58:35 INFO - Using env: {'DISPLAY': ':0', 12:58:35 INFO - 'HOME': '/home/cltbld', 12:58:35 INFO - 'LANG': 'en_US.UTF-8', 12:58:35 INFO - 'LANGUAGE': 'en_US:en', 12:58:35 INFO - 'LOGNAME': 'cltbld', 12:58:35 INFO - 'MAIL': '/var/mail/cltbld', 12:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:35 INFO - 'MOZ_NO_REMOTE': '1', 12:58:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:35 INFO - 'NO_EM_RESTART': '1', 12:58:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:35 INFO - 'PWD': '/builds/slave/test', 12:58:35 INFO - 'SHELL': '/bin/bash', 12:58:35 INFO - 'SHLVL': '1', 12:58:35 INFO - 'TERM': 'linux', 12:58:35 INFO - 'TMOUT': '86400', 12:58:35 INFO - 'USER': 'cltbld', 12:58:35 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474915833.129190-622452387', 12:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:35 INFO - '_': '/tools/buildbot/bin/python'} 12:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:35 INFO - Downloading/unpacking blobuploader==1.2.4 12:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:37 INFO - Downloading blobuploader-1.2.4.tar.gz 12:58:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:58:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:58:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:38 INFO - Downloading docopt-0.6.1.tar.gz 12:58:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:58:38 INFO - Installing collected packages: blobuploader, requests, docopt 12:58:38 INFO - Running setup.py install for blobuploader 12:58:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:58:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:58:38 INFO - Running setup.py install for requests 12:58:39 INFO - Running setup.py install for docopt 12:58:39 INFO - Successfully installed blobuploader requests docopt 12:58:39 INFO - Cleaning up... 12:58:39 INFO - Return code: 0 12:58:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:39 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 0x7f265e23cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1387ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1384f60>, '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 0x1385d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13861d0>, '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': '836cfdc75598d54cb747368e000001a9-1474915833.129190-622452387', '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 12:58:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:58:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:58:39 INFO - Using env: {'DISPLAY': ':0', 12:58:39 INFO - 'HOME': '/home/cltbld', 12:58:39 INFO - 'LANG': 'en_US.UTF-8', 12:58:39 INFO - 'LANGUAGE': 'en_US:en', 12:58:39 INFO - 'LOGNAME': 'cltbld', 12:58:39 INFO - 'MAIL': '/var/mail/cltbld', 12:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:39 INFO - 'MOZ_NO_REMOTE': '1', 12:58:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:39 INFO - 'NO_EM_RESTART': '1', 12:58:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:39 INFO - 'PWD': '/builds/slave/test', 12:58:39 INFO - 'SHELL': '/bin/bash', 12:58:39 INFO - 'SHLVL': '1', 12:58:39 INFO - 'TERM': 'linux', 12:58:39 INFO - 'TMOUT': '86400', 12:58:39 INFO - 'USER': 'cltbld', 12:58:39 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474915833.129190-622452387', 12:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:39 INFO - '_': '/tools/buildbot/bin/python'} 12:58:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:58:39 INFO - Running setup.py (path:/tmp/pip-9Oiz8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:58:39 INFO - Running setup.py (path:/tmp/pip-fv9mjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:58:39 INFO - Running setup.py (path:/tmp/pip-8J5SW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:58:39 INFO - Running setup.py (path:/tmp/pip-0j_MYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:58:39 INFO - Running setup.py (path:/tmp/pip-y1cMR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:58:39 INFO - Running setup.py (path:/tmp/pip-0VUJDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:58:39 INFO - Running setup.py (path:/tmp/pip-a14xXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:58:39 INFO - Running setup.py (path:/tmp/pip-qS1GCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:58:40 INFO - Running setup.py (path:/tmp/pip-HaM5pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:58:40 INFO - Running setup.py (path:/tmp/pip-lNv2vH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:58:40 INFO - Running setup.py (path:/tmp/pip-AFhNZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:58:40 INFO - Running setup.py (path:/tmp/pip-13s3Kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:58:40 INFO - Running setup.py (path:/tmp/pip-GDCsPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:58:40 INFO - Running setup.py (path:/tmp/pip-6lnHtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:58:40 INFO - Running setup.py (path:/tmp/pip-PZyk7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:58:40 INFO - Running setup.py (path:/tmp/pip-ncrDQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:58:40 INFO - Running setup.py (path:/tmp/pip-STJ8Bc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:58:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:58:40 INFO - Running setup.py install for manifestparser 12:58:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:58:40 INFO - Running setup.py install for mozcrash 12:58:40 INFO - Running setup.py install for mozdebug 12:58:41 INFO - Running setup.py install for mozdevice 12:58:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:58:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:58:41 INFO - Running setup.py install for mozfile 12:58:41 INFO - Running setup.py install for mozhttpd 12:58:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:58:41 INFO - Running setup.py install for mozinfo 12:58:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:58:41 INFO - Running setup.py install for mozInstall 12:58:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:58:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:58:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:58:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:58:41 INFO - Running setup.py install for mozleak 12:58:41 INFO - Running setup.py install for mozlog 12:58:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:58:41 INFO - Running setup.py install for moznetwork 12:58:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:58:41 INFO - Running setup.py install for mozprocess 12:58:41 INFO - Running setup.py install for mozprofile 12:58:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:58:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:58:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:58:42 INFO - Running setup.py install for mozrunner 12:58:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:58:42 INFO - Running setup.py install for mozscreenshot 12:58:42 INFO - Running setup.py install for moztest 12:58:42 INFO - Running setup.py install for mozversion 12:58:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:58:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:58:42 INFO - Cleaning up... 12:58:42 INFO - Return code: 0 12:58:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:42 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 0x7f265e23cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1387ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1384f60>, '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 0x1385d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13861d0>, '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': '836cfdc75598d54cb747368e000001a9-1474915833.129190-622452387', '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 12:58:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:58:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:58:42 INFO - Using env: {'DISPLAY': ':0', 12:58:42 INFO - 'HOME': '/home/cltbld', 12:58:42 INFO - 'LANG': 'en_US.UTF-8', 12:58:42 INFO - 'LANGUAGE': 'en_US:en', 12:58:42 INFO - 'LOGNAME': 'cltbld', 12:58:42 INFO - 'MAIL': '/var/mail/cltbld', 12:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:42 INFO - 'MOZ_NO_REMOTE': '1', 12:58:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:42 INFO - 'NO_EM_RESTART': '1', 12:58:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:42 INFO - 'PWD': '/builds/slave/test', 12:58:42 INFO - 'SHELL': '/bin/bash', 12:58:42 INFO - 'SHLVL': '1', 12:58:42 INFO - 'TERM': 'linux', 12:58:42 INFO - 'TMOUT': '86400', 12:58:42 INFO - 'USER': 'cltbld', 12:58:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474915833.129190-622452387', 12:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:42 INFO - '_': '/tools/buildbot/bin/python'} 12:58:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:58:42 INFO - Running setup.py (path:/tmp/pip-uhzlPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:58:42 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:58:42 INFO - Running setup.py (path:/tmp/pip-svGOym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:58:42 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)) 12:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:58:42 INFO - Running setup.py (path:/tmp/pip-B9KaRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:58:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:58:42 INFO - Running setup.py (path:/tmp/pip-4RjQw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:58:43 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)) 12:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:58:43 INFO - Running setup.py (path:/tmp/pip-VkEhLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:58:43 INFO - Running setup.py (path:/tmp/pip-sNbrMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:58:43 INFO - Running setup.py (path:/tmp/pip-VpKaQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:58:43 INFO - Running setup.py (path:/tmp/pip-25HOdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:58:43 INFO - Running setup.py (path:/tmp/pip-qRsfsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:58:43 INFO - Running setup.py (path:/tmp/pip-Qca96m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:58:43 INFO - Running setup.py (path:/tmp/pip-q1GM8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:58:43 INFO - Running setup.py (path:/tmp/pip-Dup3wu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:58:43 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)) 12:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:58:43 INFO - Running setup.py (path:/tmp/pip-l7KRyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:58:43 INFO - Running setup.py (path:/tmp/pip-VPXOIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:58:43 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)) 12:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:58:43 INFO - Running setup.py (path:/tmp/pip-VMEzHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:58:43 INFO - Running setup.py (path:/tmp/pip-liLtfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:58:43 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)) 12:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:58:43 INFO - Running setup.py (path:/tmp/pip-WgN04g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:58:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:45 INFO - Downloading blessings-1.6.tar.gz 12:58:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:58:45 INFO - Installing collected packages: blessings 12:58:45 INFO - Running setup.py install for blessings 12:58:46 INFO - Successfully installed blessings 12:58:46 INFO - Cleaning up... 12:58:46 INFO - Return code: 0 12:58:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:58:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:58:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:58:46 INFO - Reading from file tmpfile_stdout 12:58:46 INFO - Current package versions: 12:58:46 INFO - argparse == 1.2.1 12:58:46 INFO - blessings == 1.6 12:58:46 INFO - blobuploader == 1.2.4 12:58:46 INFO - docopt == 0.6.1 12:58:46 INFO - functools32 == 3.2.3-2 12:58:46 INFO - jsonschema == 2.5.1 12:58:46 INFO - manifestparser == 1.1 12:58:46 INFO - mozInstall == 1.12 12:58:46 INFO - mozcrash == 0.17 12:58:46 INFO - mozdebug == 0.1 12:58:46 INFO - mozdevice == 0.48 12:58:46 INFO - mozfile == 1.2 12:58:46 INFO - mozhttpd == 0.7 12:58:46 INFO - mozinfo == 0.9 12:58:46 INFO - mozleak == 0.1 12:58:46 INFO - mozlog == 3.4 12:58:46 INFO - moznetwork == 0.27 12:58:46 INFO - mozprocess == 0.23 12:58:46 INFO - mozprofile == 0.28 12:58:46 INFO - mozrunner == 6.12 12:58:46 INFO - mozscreenshot == 0.1 12:58:46 INFO - mozsystemmonitor == 0.3 12:58:46 INFO - moztest == 0.7 12:58:46 INFO - mozversion == 1.4 12:58:46 INFO - psutil == 3.1.1 12:58:46 INFO - requests == 1.2.3 12:58:46 INFO - wsgiref == 0.1.2 12:58:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f265e23cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1387ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1384f60>, '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 0x1385d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13861d0>, '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': '836cfdc75598d54cb747368e000001a9-1474915833.129190-622452387', '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 12:58:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:58:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:58:46 INFO - Using env: {'DISPLAY': ':0', 12:58:46 INFO - 'HOME': '/home/cltbld', 12:58:46 INFO - 'LANG': 'en_US.UTF-8', 12:58:46 INFO - 'LANGUAGE': 'en_US:en', 12:58:46 INFO - 'LOGNAME': 'cltbld', 12:58:46 INFO - 'MAIL': '/var/mail/cltbld', 12:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:46 INFO - 'MOZ_NO_REMOTE': '1', 12:58:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:46 INFO - 'NO_EM_RESTART': '1', 12:58:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:46 INFO - 'PWD': '/builds/slave/test', 12:58:46 INFO - 'SHELL': '/bin/bash', 12:58:46 INFO - 'SHLVL': '1', 12:58:46 INFO - 'TERM': 'linux', 12:58:46 INFO - 'TMOUT': '86400', 12:58:46 INFO - 'USER': 'cltbld', 12:58:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474915833.129190-622452387', 12:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:46 INFO - '_': '/tools/buildbot/bin/python'} 12:58:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:58:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:58:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:58:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:58:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:58:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:58:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:58:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:58:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:58:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:58:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:58:46 INFO - Cleaning up... 12:58:46 INFO - Return code: 0 12:58:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f265e23cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1387ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1384f60>, '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 0x1385d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13861d0>, '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': '836cfdc75598d54cb747368e000001a9-1474915833.129190-622452387', '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 12:58:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:58:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:58:46 INFO - Using env: {'DISPLAY': ':0', 12:58:46 INFO - 'HOME': '/home/cltbld', 12:58:46 INFO - 'LANG': 'en_US.UTF-8', 12:58:46 INFO - 'LANGUAGE': 'en_US:en', 12:58:46 INFO - 'LOGNAME': 'cltbld', 12:58:46 INFO - 'MAIL': '/var/mail/cltbld', 12:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:46 INFO - 'MOZ_NO_REMOTE': '1', 12:58:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:46 INFO - 'NO_EM_RESTART': '1', 12:58:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:46 INFO - 'PWD': '/builds/slave/test', 12:58:46 INFO - 'SHELL': '/bin/bash', 12:58:46 INFO - 'SHLVL': '1', 12:58:46 INFO - 'TERM': 'linux', 12:58:46 INFO - 'TMOUT': '86400', 12:58:46 INFO - 'USER': 'cltbld', 12:58:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474915833.129190-622452387', 12:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:46 INFO - '_': '/tools/buildbot/bin/python'} 12:58:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:58:46 INFO - Cleaning up... 12:58:46 INFO - Return code: 0 12:58:46 INFO - Running post-action listener: _resource_record_post_action 12:58:46 INFO - Running post-action listener: _start_resource_monitoring 12:58:46 INFO - Starting resource monitoring. 12:58:46 INFO - [mozharness: 2016-09-26 19:58:46.833360Z] Finished create-virtualenv step (success) 12:58:46 INFO - [mozharness: 2016-09-26 19:58:46.833965Z] Running install step. 12:58:46 INFO - Running pre-action listener: _resource_record_pre_action 12:58:46 INFO - Running main action method: install 12:58:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:58:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:58:47 INFO - Reading from file tmpfile_stdout 12:58:47 INFO - Detecting whether we're running mozinstall >=1.0... 12:58:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:58:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:58:47 INFO - Reading from file tmpfile_stdout 12:58:47 INFO - Output received: 12:58:47 INFO - Usage: mozinstall [options] installer 12:58:47 INFO - Options: 12:58:47 INFO - -h, --help show this help message and exit 12:58:47 INFO - -d DEST, --destination=DEST 12:58:47 INFO - Directory to install application into. [default: 12:58:47 INFO - "/builds/slave/test"] 12:58:47 INFO - --app=APP Application being installed. [default: firefox] 12:58:47 INFO - mkdir: /builds/slave/test/build/application 12:58:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:58:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:59:03 INFO - Reading from file tmpfile_stdout 12:59:03 INFO - Output received: 12:59:03 INFO - /builds/slave/test/build/application/firefox/firefox 12:59:03 INFO - Running post-action listener: _resource_record_post_action 12:59:03 INFO - [mozharness: 2016-09-26 19:59:03.102772Z] Finished install step (success) 12:59:03 INFO - [mozharness: 2016-09-26 19:59:03.103019Z] Running run-tests step. 12:59:03 INFO - Running pre-action listener: _resource_record_pre_action 12:59:03 INFO - Running main action method: run_tests 12:59:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:59:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:59:03 INFO - Python 2.7.3 12:59:03 INFO - Return code: 0 12:59:03 INFO - grabbing minidump binary from tooltool 12:59:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:59:03 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 0x1384f60>, '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 0x1385d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13861d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:59:03 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 12:59:03 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 12:59:03 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 12:59:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:59:03 INFO - Return code: 0 12:59:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:59:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:59:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:59:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:59:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:59:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e-zwRMXWRUauU4vu4aLIXA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:59:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e-zwRMXWRUauU4vu4aLIXA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:59:03 INFO - Using env: {'DISPLAY': ':0', 12:59:03 INFO - 'HOME': '/home/cltbld', 12:59:03 INFO - 'LANG': 'en_US.UTF-8', 12:59:03 INFO - 'LANGUAGE': 'en_US:en', 12:59:03 INFO - 'LOGNAME': 'cltbld', 12:59:03 INFO - 'MAIL': '/var/mail/cltbld', 12:59:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:59:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:59:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:03 INFO - 'MOZ_NO_REMOTE': '1', 12:59:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:59:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:59:03 INFO - 'NO_EM_RESTART': '1', 12:59:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:59:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:03 INFO - 'PWD': '/builds/slave/test', 12:59:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:59:03 INFO - 'SHELL': '/bin/bash', 12:59:03 INFO - 'SHLVL': '1', 12:59:03 INFO - 'TERM': 'linux', 12:59:03 INFO - 'TMOUT': '86400', 12:59:03 INFO - 'USER': 'cltbld', 12:59:03 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1474915833.129190-622452387', 12:59:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:03 INFO - '_': '/tools/buildbot/bin/python'} 12:59:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e-zwRMXWRUauU4vu4aLIXA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:59:03 INFO - mozversion application_buildid: 20160926094950 12:59:03 INFO - mozversion application_changeset: 82908a457460732127a3790a75ba56459792cec7 12:59:03 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:59:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:59:03 INFO - mozversion application_name: Firefox 12:59:03 INFO - mozversion application_remotingname: firefox-dev 12:59:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:59:03 INFO - mozversion application_vendor: Mozilla 12:59:03 INFO - mozversion application_version: 51.0a2 12:59:03 INFO - mozversion platform_buildid: 20160926094950 12:59:03 INFO - mozversion platform_changeset: 82908a457460732127a3790a75ba56459792cec7 12:59:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:59:03 INFO - mozversion platform_version: 51.0a2 12:59:03 INFO - using testdate: 1474919943 12:59:03 INFO - actual date: 1474919943 12:59:03 INFO - starting webserver on 'localhost:60576' 12:59:03 INFO - SUITE-START | Running 2 tests 12:59:03 INFO - TEST-START | dromaeo_css 12:59:03 INFO - operating with platform_type : linux_ 12:59:03 INFO - Initialising browser for dromaeo_css test... 12:59:03 INFO - TEST-INFO | started process 30189 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy0leuP/profile http://localhost:60576/getInfo.html) 12:59:07 INFO - PROCESS | 30189 | __metrics Screen width/height:1600/1200 12:59:07 INFO - PROCESS | 30189 | colorDepth:24 12:59:07 INFO - PROCESS | 30189 | Browser inner width/height: 1024/697 12:59:07 INFO - PROCESS | 30189 | __metrics 12:59:08 INFO - PROCESS | 30189 | 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" 12:59:08 INFO - PROCESS | 30189 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:59:08 INFO - PROCESS | 30189 | console.error: PushService: 12:59:08 INFO - PROCESS | 30189 | stateChangeProcessEnqueue: Error transitioning state 12:59:08 INFO - PROCESS | 30189 | UnknownError 12:59:09 INFO - TEST-INFO | 30189: exit 0 12:59:09 INFO - Browser initialized. 12:59:09 INFO - Running cycle 1/1 for dromaeo_css test... 12:59:09 INFO - TEST-INFO | started process 30278 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy0leuP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:59:20 INFO - PROCESS | 30278 | RSS: Main: 147382272 12:59:20 INFO - PROCESS | 30278 | 13:00:12 INFO - PROCESS | 30278 | 1474920012078 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] 13:02:21 INFO - PROCESS | 30278 | Cycle 1(1): loaded http://localhost:60576/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60576/tests/dromaeo/cssquery-ext.html) 13:02:22 INFO - PROCESS | 30278 | RSS: Main: 238944256 13:02:22 INFO - PROCESS | 30278 | 13:05:24 INFO - PROCESS | 30278 | Cycle 1(1): loaded http://localhost:60576/tests/dromaeo/cssquery-ext.html (next: http://localhost:60576/tests/dromaeo/cssquery-jquery.html) 13:05:25 INFO - PROCESS | 30278 | RSS: Main: 228012032 13:05:25 INFO - PROCESS | 30278 | 13:08:27 INFO - PROCESS | 30278 | Cycle 1(1): loaded http://localhost:60576/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60576/tests/dromaeo/cssquery-mootools.html) 13:08:27 INFO - PROCESS | 30278 | RSS: Main: 174022656 13:08:27 INFO - PROCESS | 30278 | 13:11:29 INFO - PROCESS | 30278 | Cycle 1(1): loaded http://localhost:60576/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60576/tests/dromaeo/cssquery-prototype.html) 13:11:30 INFO - PROCESS | 30278 | RSS: Main: 200220672 13:11:30 INFO - PROCESS | 30278 | 13:14:32 INFO - PROCESS | 30278 | Cycle 1(1): loaded http://localhost:60576/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60576/tests/dromaeo/cssquery-yui.html) 13:14:33 INFO - PROCESS | 30278 | RSS: Main: 176562176 13:14:33 INFO - PROCESS | 30278 | 13:17:35 INFO - PROCESS | 30278 | Cycle 1(1): loaded http://localhost:60576/tests/dromaeo/cssquery-yui.html (next: http://localhost:60576/tests/dromaeo/cssquery-dojo.html) 13:17:36 INFO - PROCESS | 30278 | RSS: Main: 268271616 13:17:36 INFO - PROCESS | 30278 | 13:17:36 INFO - PROCESS | 30278 | __start_tp_report 13:17:36 INFO - PROCESS | 30278 | _x_x_mozilla_page_load 13:17:36 INFO - PROCESS | 30278 | _x_x_mozilla_page_load_details 13:17:36 INFO - PROCESS | 30278 | |i|pagename|runs| 13:17:36 INFO - PROCESS | 30278 | |0;dojo.html;3097.2566584019837;3143.0885043337435;3148.574942382778;3157;3191.218151552868;5596.692181929992;5667.5749318801045;5685.118806584986;5737.684427356494;5743.081107022877;5690.7723691052415;5747.396523365049;5754.971225143879;5763.942360576393;5795.739191736371;5191.351081114861;5204.739763011853;5224.373075230958;5260.0268950244135;5303.787848486075;5067.619928505358;5284.524392804647;5290.0477913975465;5293.311869456965;5322.547583455411;5056.544910958013;5158.845234642967;5198.636095473299;5256;5288.15389537674;5201.843944681666;5311.814086506993;5313.893722125575;5320.627556071096;5321.095413779628;5131.947950670141;5172.32759741235;5255.500727430888;5268.0517506848755;5276.841694749163;5501.174823776466;5544.584156188302;5548.278723765925;5566.972165139148;5644.604877658566;5968.253968253968;5976.581639285252;5986.982213023796;6069.271687397496;6074.48366888815;6120.204373431426;6131.988221943374;6138.69306534676;6145.631262124287;6155.938440615581;5490.780368785244;5542;5577.637453565505;5647.717614119278;5661.405552417019;6223.253209614875;6243.148978574987;6278.937210627927;6282.1519094921605;6283.748650053946;5991.340952495222;6013.428724271187;6016.879662406727;6021.126936594257;6052.122442245938;5858.677772722541;5905.645661260252;5961;6030.728617212236;6032.487238584682;6070.666113363807;6078.331383547807;6079.756809727562;6080.574359794772;6101.237345331833;6079.817605471843;6087.54343424245;6087.54343424245;6095.329513753483;6100.908486372708;4525.52481989393;4563.247064234431;4602.194615942197;4657.371254880615;4666.603338716247;4136.400221967858;4150.169966006811;4150.501939767248;4164.5210800757695;4167.229062623424;5876.44173803488;5883.588148829626;5884.382139875252;5884.911726324109;5886.793962211302;5883.235179426732;5930.8813823723285;5978.432048955342;6185.443310102022;6192.164057852132;5700.458456446631;5799.420057994167;5810.041343178413;5818.389069147678;5843.29880414353;5251.894962100737;5260.605454590845;5265.183896496049;5268.473152684701;5281.973590132025;6046.244219472566;6107.114468401968;6201.472874805692;6238.095476155932;6249.281332646804;5941.643501389757;6024.698765061817;6030.03519436888;6115.757578773102;6118.741008805849;6282.528810339151;6284.937150628435;6290.0879372491645;6294.15028971083;6302.779402720883;6001.849953751016;6005.90991135142;6006.369331220334;6025.367336429612;6026.7287972040485;5815.447532484407;5927.4665280125;6002.189704389852;6044.425779550936;6073.0283154695035;5919.6744179070565;5958.433948774859;5959.612625179349;5971.731272092853;5988.610740301867;5910.822675319747;5952;5952.851178720567;5970.253718285215;5972.402759723993;5683.090705487102;5733.627314224562;5792.739326730223;5794.18881356602;5848.0350742127075;5970.194023806731;5984.581079324405;5989.550783691154;6002.399760024137;6018.608790428608;5566;5848.2689663792025;5853.03424934881;5855.795047173328;5858.443447872445 13:17:36 INFO - PROCESS | 30278 | |1;ext.html;593.462916060965;622.9252489701237;648.5654611410355;650.1612919334059;656.1076935367898;35857;38854;47257.29114063288;47717.52282477174;48060;48861.267080993726;49228.50771492284;49269.753651231695;49293.50706492934;49311;9286.349955503118;9313.906860931405;9399.107084826965;9439.905600944006;9442.386244894094;8549.700760473384;8778.16607422297;11026.889731102707;11276.830847537294;11282.605108821193;11449.713757156096;11508.42457877107;11521;11528.596499122532;11529.711757206094;11291.774164516704;11320.547178112865;11353.716157096056;11364.715882102932;11365.659030229024;11191.2725672831;11217.66347009591;11231.21381503295;11249.156313276537;11257.099432045417;44955.32567011497;45270.773646131885;45354;45369.31946020779;45443.54556454426;3837.3668344723087;3868.439076333944;4097.651699605507;4173.895652608679;4522.6758332625495;34651.82674086639;35008.47487287693;35250;35260.82369588161;35482.822585886905;4467.486239082515;4491.101779644052;4500.3249512573375;4588.357629931812;4602.838900638495;374437;376285;376435;377614;377805;62334;62633.373666263666;62668.68665656734;62719.059214111825;62867;40433.59566404357;41423.7928810354;41434.37848432276;43683.563164368585;68346.65826670935;18434;18606.255749770127;18698.626027479648;18699.158537865827;18700.158492867853;12888.097833151589;13392.464301428028;14417.711645767025;14523.709525809636;14530.05554638945;20439.591208175752;21038.36884893425;21063.68404473934;21767.891160544412;22108.88945555262;6350.682465876687;7316.634168291671;7350.4119670426235;7467.551946883204;7574.394048476109;975.8926518083006;1002.4436437776958;1038.99480502597;1046.3826342457987;1083.859656113654;32303.192420189684;34448;34675.65324346775;34868.85497924589;34987.30025399478;1115.1357697784283;1134.9659510214706;1146.478352349679;1183.4201241391656;1252.04218772639;16960;17883.28466861337;18045.548861278574;18071.186796594186;18133.637327253382;497518;503343;503648;504839;504894;63063.684681577215;63624.36375636277;63726.36273637297;63746;63766.36233637697;1336.084781924385;1388.1740364483117;1405.6766943602825;1440.7838824176458;1462.7074585083026;32760.50859237161;36119.27761444809;36217.275654486235;36524.63475365212;36608.81695591612;53956.73021634867;54511.72744136413;54561.181582277095;54573.45426545842;54626.72686636541;445145;447650;447727;447914;448235;31190.844045779624;32146.35707285888;32377.190570235933;32417.35165296728;32536;52142.47857521376;52631;52648.210276845115;52924.735376322875;53672;43875.12249755051;44951.775241124895;45212.321815173455;45236.773816130706;46686.76656616695;43150.78424607857;44573;45112.54887451084;45174.77412612916;46100.07799843917;43687;43978;44795.77602111969;44827.775861120484;45084.77457612691;36857.26285474329;39683.404748929366;40306.395404068375;40670.186596268504;40723;29461.705382945896;30028.699713003465;30854.84572577123;30961.845190773904;32416.189595260308 13:17:36 INFO - PROCESS | 30278 | |2;jquery.html;395.28453499166494;429.51035819166157;430.4890996087784;435.3143798517335;441.7040582809519;16156.596085097879;18933;20664.690029649566;20824.583508329863;21158;18748;19291.421257362268;19402.51493712658;19428.222871085174;19549.609007819836;5875.7062146892695;6080.2399700037495;6086.726097325609;6090.177825993501;6090.634561926277;5759.193712880179;5972.73122709477;6001.429864162919;6004.729787159588;6006.7897623583185;5724.914126288109;5961.403859614047;5969.343372229073;5969.910451343233;5975.581709280352;5883.294004719418;5887.8233652990475;5914.053751399777;5953.732082056318;5962.04607262838;5152.92270615941;5187.533122018998;5261.605379596545;5340.172273297606;5340.359156901197;24277.635835462483;24318.148864789826;24605;24682.382940426454;24814.627780583305;2630.973690263111;2754.7520723135012;3135.749140068789;3137.905862824119;3219.259570298821;14976.625584360478;15205.391784328614;15540.689186216212;15547.689046219126;15929.442469513511;1942.9611407771906;1946.6690662587393;1955.3840540229783;2000.249906285143;2000.399880035998;52919.735401322745;62003.689981550255;84123.99999999939;86270;86379;9800.26498012652;10573.577056917791;10726.731831704114;10796.082333001626;11650.475728592233;14288.57134285973;14329.283535823375;15329.9233503834;15376.61558461025;15944.920275398781;8498.045449546638;8509.914900851036;8815.779605509913;8881.42270752399;8964.32462690307;8345.833083338299;8351.874721879176;8364.749057528285;8504.362172837062;8530.573471326408;4718.292256161603;4875.634327425386;4916.262560615936;5050.318207042076;5180.32655754757;2073.6060148572024;2088.832893368527;2095.6018356512213;2099.0583710068126;2133.6159491291405;992.6624947517879;1014.7412409835445;1026.2816028779885;1035.435687550287;1069.9518521666544;19504.70742938857;20243.190272389234;20249.291274805604;20335.389938301876;20401;973.2408721197477;994.3735446668552;1015.746063484129;1042.4006196437078;1049.8372752223265;10378.792424151474;11102.944485277521;11103.44482775858;11135.220534562503;11366.602168924048;490567;507456;508903;511290;513259;93334.53332733293;95554;98232.52651210237;99828.99999999854;99858;1005.215931573374;1022.0903395977585;1039.5789705169418;1045.994770026145;1049.532957833772;17184.742228866828;17424.738628920324;17458.73811892848;18313.816861831212;18445.26218951227;43605.34591981059;44466.3330050043;45431.54568454273;45780.31329530126;45895.3115703258;54374.184387235015;54740.726296368266;55274.44725552854;56146.71926640504;57939.13091303718;8095.87856182146;8498.70254541088;8617.69838055665;8967.820643587222;8974.641014359353;12607;13040.804387933998;13588.116772409761;13770.862291376958;13777.862221377658;11566.768664626828;11714.648560543197;12082.697932551757;12106.576269830513;12120.151589388659;11670.358130302915;11712.472938717949;11841.703957401134;11922.642320730392;12093.939530302292;11589.24669896454;11991.700207494883;12106.213096148722;12197.085218608463;12227.004383925994;8253.587320633824;8275.751727448187;8327.458715183493;8345.123762005145;8356.955380577429;10188.541515631667;11930.105242106703;12084.758304833678;12093.213941093802;12250.081243906921 13:17:36 INFO - PROCESS | 30278 | |3;mootools.html;1416.3626368134342;1478.2904205981129;1520.2170881995771;1679.8488136067758;1839.3838064248469;7908.090569584492;8589.09814469481;9062.818743625123;9375.343725939187;9384.436933783978;9588.904110958889;9662.033796620335;9674.854877176831;9678.370905891112;9678.758031049227;2518.508890766301;2541.898324067035;2543.275166577526;2543.898244070235;2545.681789776278;2520.4707011527507;2588.676415448069;2590.209985954283;2592.392716515763;2592.429665473602;2508.5610018246734;2521.5461216980934;2547.1467058535413;2547.9872600636972;2549.1715192562397;2429.6234083717054;2441.060191826142;2445.76765207305;2463.9753602464016;2474.9628755568683;2397.1490121006964;2422;2426.733059363469;2429.9149529766373;2440.9511809763885;9333.766655833591;9448.149666530046;9454;9466.668666596635;9474.431534107976;5449.618526703132;5651.519620832234;5657.886842263173;5718.370979192286;5756.079027355645;3736.5889752127246;3755.3052685253315;3762.322781899257;3918.3142949983926;3928.9017774555577;1241.2118304876378;1270.1870802686287;1274.2481935658006;1279.6225113591513;1335.0854664554713;13356.86643133566;13373.53192638253;13421.993350498655;13447.86552134476;13451.32743362828;4740.265258884879;4783.928241076386;4961.751912404366;5035.446100928895;5115.232715092691;10399.32404393712;10436.739081523023;10461.895381046092;10462.163026957825;10487.528061237263;5549.639273447213;5584;5590.161475778666;5592.384837667853;5598.944010559842;4172;4428.7121337112985;4463.330500424962;4556.407667003268;5220.295260139833;3874.9031274217805;3991.640752332304;4005.2790497710107;4014.036631208489;4104.91790164195;1242.1491278474275;1270.3775150176348;1272.408330126477;1279.4754150798128;1286;966.3090890013674;984.9113579777854;985.7410713841592;988.3081842710131;993.4039576254189;6107.7862274821055;6109.663968481687;6220.937790622126;6237.220347456568;6509.837254068591;987.8123156600367;1002.5438425516372;1022.5091955861079;1043.3062013760916;1044.3055368180076;4295.334223195409;4473.507914129443;4480.238359478896;4485.573870482364;4536.9092618148115;11520.308781473139;11960.760784784256;11993.340366279765;12005.279683219034;12070.094742894318;11395.145364097725;11746.823797643043;11890.821637675443;11928.343941083323;11948.402579870972;8059.637316320663;8521.275691566287;8561.657533698582;8624.870626940601;8690.782730431663;6095.695215239309;6350.301466838737;6463.57986730861;6485.805425837232;6586.50601204902;10480.947595261974;10913.23607347478;10966.725831854268;11013.449327533752;11024.669259922215;10405.687829365132;10432.113270372103;10646.467676616294;11060.336379817236;11125.276857004268;8341;8341.45780524264;8372.66509339644;8462.069172391155;8466.449680770731;8705.782355441164;8823.029466758522;8833.425827321204;8854.734357969272;8883.600237989176;8089.312408445348;8149.225823546753;8326.750197494084;8343.833123337621;8532.744017679479;8121.715739949073;8131.634076466455;8236.176382361717;8292.709755158541;8455.365847561581;7664.463487555818;7677.500962437423;7726.3432608226685;7727.690892364242;7757.844843103219;5488.506034456918;5675.914861277167;5744.138379243147;5751.367349591458;5859.589828711949;5441.347038355423;5468.179773034077;5649.7740090397565;5723.227364305765;5783.306003279633 13:17:36 INFO - PROCESS | 30278 | |4;prototype.html;333.56469806902;345.47660294653605;351.5412386835181;354.4258301551487;356.84120566347985;5622;5629.831105066849;5689.9999999999945;5709.344290155855;5716.8856622867515;5293.9735301323535;5380.192971054344;5403.162509810985;5442.265294185284;5561.610687251894;4259.63793077588;4266.701330906838;4358.673099517533;4372.431583894106;4415.492218394877;4377.737335759864;4395.626371758404;4404.788683112154;4426.756528390937;4426.77866106695;4149.7095203335775;4323.5460276670965;4345.456817897762;4353.542877997812;4384.8026838792175;4313.849015284466;4321.200577893084;4325.199838029943;4328.826846926119;4368.148211098837;3832.0419895026243;3832.8658496952753;3833.9424908626393;3850;3872.806359682033;5229.790808367661;5376.650517716336;5414.729263536847;5437.673739575638;5442.210879422501;4965.155923492979;4984.077945580079;4992.326035985132;4994.275830004665;5026.723530205837;5819.476247137778;5896.498797602209;5915.1718759373725;5920.141579470996;5926.792562260343;4052.1085361220485;4184.560621134798;4247.426597409372;4257.934901572735;4265.296226122686;6059.757609695607;6066.725987542622;6074.149619053336;6090.604110732833;6110.816675499742;4288.31386978082;4293.570642935744;4302.139572085595;4302.548232435612;4350.108227813291;4260.4248426462655;4335.3713711511655;4345.739255644608;4404.361367601679;4415.139047885696;4953.826616068421;4980.252962055648;4980.452150263468;5004.299398084271;5022.347094877642;5847.619904706181;5910.763569457259;5949.940500594938;5959.791407300723;5973.551983601247;1406.648337915521;1435.4760512412895;1458.9865984940714;1502.9323680434406;1518.7342215112312;986.6004268271362;1012.4785735346303;1015.9949200254099;1025.3437799808128;1026.1175389165312;5636.943630563642;5707.6290041147195;5709.286339207599;5714.228579141763;5765.4522820332;5631.662100273997;5921.822345329647;5930.466258036798;5942.376050514634;5943.55423343251;5623.578231632644;5639.2668953035845;5650.689212093293;5671.064274394678;5687.241687781423;3115.454795410794;3133.733632641251;3146.7639927005566;3162.6204855417036;3163.778535502539;5826.6795326256615;5955.702214889238;6001.549883758736;6002.249718785152;6033;5952.958232309328;5961.433663801932;5963.79126730571;5968.582199246011;5970;5821.621594596338;6004.42957918997;6009.2188015557695;6046.54650901193;6089.021068152868;5805.622634528742;5813.6221145625395;5842.269716285465;5858.238429004202;5885.793997210077;5653.632513886749;5812.099124635688;5824.737886795189;5885.881682480315;5907.9704601476715;5977.820665380045;6007.639541627516;6055.576109672457;6061.333253342041;6064.302605200459;4264.658827293747;4267.125239325993;4282.950677084134;4283.935740963951;4295.978520107379;5618.634788738719;5851.765929362778;5857.1799948008165;5915.792947246826;5969.373215812451;5710.885782284248;5716.885662286814;5741.110127930177;5784.248047753765;5827.329857066322;5724.484796368347;5728.396049106091;5753.1370294456165;5782.641079346435;5808.722081142142;5390.703511306916;5659.801906933238;5707.372189059283;5809.970950145223;5818.421670672421;5886.646801191942;5893.349862038636;5898.554854060782;5919.720907450748;5929.6145750526075;5545.944540554704;5750.654960702204;5760.567957403127;5821.301443826768;5837.153612726046 13:17:36 INFO - PROCESS | 30278 | |5;yui.html;817.7178873288715;825.5005721538469;830.8172202115536;848.8726690996351;914.113111561544;16785.1607419629;18319.725204121933;18476.260949562;18503.0748462577;18519.629607407845;14601.415943362254;16702.08138552379;16891;17010.234539445722;17076;853.850576149173;874.2743522875998;876.2026555834192;876.4828751036887;879.4942907827992;876.5310558851016;877.079066979672;879.643744283563;879.9516026618534;880.0671288434248;922.7831459606987;930.6137952749601;931.7018554062703;932.7108596335158;932.7854593443512;923.4459324405336;923.4690053219425;924.2328867040341;924.6809850601531;924.8658944453084;680.5100327764002;682.2836022176695;682.3619915379087;682.8292926768308;682.8839097353462;14913.403463861432;15139.54581362561;15161.545153645407;15210.847891521054;15935.362585496567;13775.862241377557;13790.241536715477;14027.002628442102;14175.64560885986;14673.046251993586;13875.583732488041;14069.2965351732;14116.647083822987;14139.575812725634;14272.714545709132;4658.394408726877;4698.859034228944;4702.435707715096;4735;4841.644339584886;70606.64696676483;71754.28245717529;72268.63865680638;83919.74120388138;90042.54978725064;12250.081243906743;12461.626151215478;12731.045171612166;12754;12846.293453860128;22354.888225558767;22546.21088261903;22582.661260081113;23273.7672623275;23360.18239361614;9529.475878826732;9647.421154730739;9687.32188746781;9691.466969316756;9832.655857044969;5010.599152067826;5260.44765299638;5279.788808447696;5330.120530112488;5332.866678333073;3777.036855601859;3906.882793516199;3914;3920.5295364555864;3923.941140882889;689.8965155226756;696.3941371007155;704.4223736536094;721.4120491799167;736.9705211791468;726.2338233164063;732.5934106570904;736.5323019882413;770.0336078221795;804.2801692485193;10247;10262.743431414125;10616.309939853885;10871.347719136877;11090.667279981613;635.0093853588417;647.7635662982977;683.4225079807554;693.7675878580732;717.3830505765038;5197.064528384927;5300.390455097636;5402.486763757437;5445.972770136124;5482.671039737628;68112;70070.64964675144;70882.64558677173;71000;140602.2969885144;100929;102839.4858025705;106969.4651526753;107687.46156269325;112616;57537;88840;91633.54183229042;92917.53541232251;98411;10194.490275486345;10653.467326633792;10882.40146791934;10895.727606809893;10960.177986650873;50469.495305047945;53797.462025379245;55702.72148639231;56646.716766415906;57046.42953570411;47212;66497;74739.62630186815;76784.2321576777;77321;14090.647733806736;14211.50259740904;14225.430982760574;14297.785533216802;14516.346764395415;16367.263473143976;16371.918140409221;16614.83385166133;16620.168991550134;17833.37583184634;14482.782758258845;14782.408703651734;14878.10731356122;14926.776098358316;15352.46266380716;14643.707125857636;15479.148646824533;15510.534683959499;15513.767293490833;16846.1576921151;14273.928630356782;14369.13785172893;14775.113493190443;15067.17130557786;16195.271212795216;12439.315837628656;12984.15602985803;13205.273709946045;13275.535356262484;13596.11625244356;12828.486860525474;12852;12857.228566286052;13077.542286019943;13111.868881311064 13:17:36 INFO - PROCESS | 30278 | __end_tp_report 13:17:36 INFO - PROCESS | 30278 | __start_cc_report 13:17:36 INFO - PROCESS | 30278 | _x_x_mozilla_cycle_collect,864 13:17:36 INFO - PROCESS | 30278 | __end_cc_report 13:17:36 INFO - PROCESS | 30278 | __startTimestamp1474921056050__endTimestamp 13:17:36 INFO - PROCESS | 30278 | 13:17:36 INFO - PROCESS | 30278 | ------- Summary: start ------- 13:17:36 INFO - PROCESS | 30278 | Number of tests: 6 13:17:36 INFO - PROCESS | 30278 | 13:17:36 INFO - PROCESS | 30278 | [#0] dojo.html Cycles:165 Average:5641.97 Median:5876.44 stddev:646.58 (11.0%) stddev-sans-first:616.98 13:17:36 INFO - PROCESS | 30278 | Values: 3097.3 3143.1 3148.6 3157.0 3191.2 5596.7 5667.6 5685.1 5737.7 5743.1 5690.8 5747.4 5755.0 5763.9 5795.7 5191.4 5204.7 5224.4 5260.0 5303.8 5067.6 5284.5 5290.0 5293.3 5322.5 5056.5 5158.8 5198.6 5256.0 5288.2 5201.8 5311.8 5313.9 5320.6 5321.1 5131.9 5172.3 5255.5 5268.1 5276.8 5501.2 5544.6 5548.3 5567.0 5644.6 5968.3 5976.6 5987.0 6069.3 6074.5 6120.2 6132.0 6138.7 6145.6 6155.9 5490.8 5542.0 5577.6 5647.7 5661.4 6223.3 6243.1 6278.9 6282.2 6283.7 5991.3 6013.4 6016.9 6021.1 6052.1 5858.7 5905.6 5961.0 6030.7 6032.5 6070.7 6078.3 6079.8 6080.6 6101.2 6079.8 6087.5 6087.5 6095.3 6100.9 4525.5 4563.2 4602.2 4657.4 4666.6 4136.4 4150.2 4150.5 4164.5 4167.2 5876.4 5883.6 5884.4 5884.9 5886.8 5883.2 5930.9 5978.4 6185.4 6192.2 5700.5 5799.4 5810.0 5818.4 5843.3 5251.9 5260.6 5265.2 5268.5 5282.0 6046.2 6107.1 6201.5 6238.1 6249.3 5941.6 6024.7 6030.0 6115.8 6118.7 6282.5 6284.9 6290.1 6294.2 6302.8 6001.8 6005.9 6006.4 6025.4 6026.7 5815.4 5927.5 6002.2 6044.4 6073.0 5919.7 5958.4 5959.6 5971.7 5988.6 5910.8 5952.0 5952.9 5970.3 5972.4 5683.1 5733.6 5792.7 5794.2 5848.0 5970.2 5984.6 5989.6 6002.4 6018.6 5566.0 5848.3 5853.0 5855.8 5858.4 13:17:36 INFO - PROCESS | 30278 | 13:17:36 INFO - PROCESS | 30278 | [#1] ext.html Cycles:180 Average:62019.61 Median:40696.59 stddev:117464.32 (288.6%) stddev-sans-first:117703.30 13:17:36 INFO - PROCESS | 30278 | Values: 593.5 622.9 648.6 650.2 656.1 35857.0 38854.0 47257.3 47717.5 48060.0 48861.3 49228.5 49269.8 49293.5 49311.0 9286.3 9313.9 9399.1 9439.9 9442.4 8549.7 8778.2 11026.9 11276.8 11282.6 11449.7 11508.4 11521.0 11528.6 11529.7 11291.8 11320.5 11353.7 11364.7 11365.7 11191.3 11217.7 11231.2 11249.2 11257.1 44955.3 45270.8 45354.0 45369.3 45443.5 3837.4 3868.4 4097.7 4173.9 4522.7 34651.8 35008.5 35250.0 35260.8 35482.8 4467.5 4491.1 4500.3 4588.4 4602.8 374437.0 376285.0 376435.0 377614.0 377805.0 62334.0 62633.4 62668.7 62719.1 62867.0 40433.6 41423.8 41434.4 43683.6 68346.7 18434.0 18606.3 18698.6 18699.2 18700.2 12888.1 13392.5 14417.7 14523.7 14530.1 20439.6 21038.4 21063.7 21767.9 22108.9 6350.7 7316.6 7350.4 7467.6 7574.4 975.9 1002.4 1039.0 1046.4 1083.9 32303.2 34448.0 34675.7 34868.9 34987.3 1115.1 1135.0 1146.5 1183.4 1252.0 16960.0 17883.3 18045.5 18071.2 18133.6 497518.0 503343.0 503648.0 504839.0 504894.0 63063.7 63624.4 63726.4 63746.0 63766.4 1336.1 1388.2 1405.7 1440.8 1462.7 32760.5 36119.3 36217.3 36524.6 36608.8 53956.7 54511.7 54561.2 54573.5 54626.7 445145.0 447650.0 447727.0 447914.0 448235.0 31190.8 32146.4 32377.2 32417.4 32536.0 52142.5 52631.0 52648.2 52924.7 53672.0 43875.1 44951.8 45212.3 45236.8 46686.8 43150.8 44573.0 45112.5 45174.8 46100.1 43687.0 43978.0 44795.8 44827.8 45084.8 36857.3 39683.4 40306.4 40670.2 40723.0 29461.7 30028.7 30854.8 30961.8 32416.2 13:17:36 INFO - PROCESS | 30278 | 13:17:36 INFO - PROCESS | 30278 | [#2] jquery.html Cycles:180 Average:29771.25 Median:13722.80 stddev:83376.51 (607.6%) stddev-sans-first:83581.23 13:17:36 INFO - PROCESS | 30278 | Values: 395.3 429.5 430.5 435.3 441.7 16156.6 18933.0 20664.7 20824.6 21158.0 18748.0 19291.4 19402.5 19428.2 19549.6 5875.7 6080.2 6086.7 6090.2 6090.6 5759.2 5972.7 6001.4 6004.7 6006.8 5724.9 5961.4 5969.3 5969.9 5975.6 5883.3 5887.8 5914.1 5953.7 5962.0 5152.9 5187.5 5261.6 5340.2 5340.4 24277.6 24318.1 24605.0 24682.4 24814.6 2631.0 2754.8 3135.7 3137.9 3219.3 14976.6 15205.4 15540.7 15547.7 15929.4 1943.0 1946.7 1955.4 2000.2 2000.4 52919.7 62003.7 84124.0 86270.0 86379.0 9800.3 10573.6 10726.7 10796.1 11650.5 14288.6 14329.3 15329.9 15376.6 15944.9 8498.0 8509.9 8815.8 8881.4 8964.3 8345.8 8351.9 8364.7 8504.4 8530.6 4718.3 4875.6 4916.3 5050.3 5180.3 2073.6 2088.8 2095.6 2099.1 2133.6 992.7 1014.7 1026.3 1035.4 1070.0 19504.7 20243.2 20249.3 20335.4 20401.0 973.2 994.4 1015.7 1042.4 1049.8 10378.8 11102.9 11103.4 11135.2 11366.6 490567.0 507456.0 508903.0 511290.0 513259.0 93334.5 95554.0 98232.5 99829.0 99858.0 1005.2 1022.1 1039.6 1046.0 1049.5 17184.7 17424.7 17458.7 18313.8 18445.3 43605.3 44466.3 45431.5 45780.3 45895.3 54374.2 54740.7 55274.4 56146.7 57939.1 8095.9 8498.7 8617.7 8967.8 8974.6 12607.0 13040.8 13588.1 13770.9 13777.9 11566.8 11714.6 12082.7 12106.6 12120.2 11670.4 11712.5 11841.7 11922.6 12093.9 11589.2 11991.7 12106.2 12197.1 12227.0 8253.6 8275.8 8327.5 8345.1 8357.0 10188.5 11930.1 12084.8 12093.2 12250.1 13:17:36 INFO - PROCESS | 30278 | 13:17:36 INFO - PROCESS | 30278 | [#3] mootools.html Cycles:180 Average:6185.85 Median:4511.24 stddev:3528.58 (78.2%) stddev-sans-first:3520.27 13:17:36 INFO - PROCESS | 30278 | Values: 1416.4 1478.3 1520.2 1679.8 1839.4 7908.1 8589.1 9062.8 9375.3 9384.4 9588.9 9662.0 9674.9 9678.4 9678.8 2518.5 2541.9 2543.3 2543.9 2545.7 2520.5 2588.7 2590.2 2592.4 2592.4 2508.6 2521.5 2547.1 2548.0 2549.2 2429.6 2441.1 2445.8 2464.0 2475.0 2397.1 2422.0 2426.7 2429.9 2441.0 9333.8 9448.1 9454.0 9466.7 9474.4 5449.6 5651.5 5657.9 5718.4 5756.1 3736.6 3755.3 3762.3 3918.3 3928.9 1241.2 1270.2 1274.2 1279.6 1335.1 13356.9 13373.5 13422.0 13447.9 13451.3 4740.3 4783.9 4961.8 5035.4 5115.2 10399.3 10436.7 10461.9 10462.2 10487.5 5549.6 5584.0 5590.2 5592.4 5598.9 4172.0 4428.7 4463.3 4556.4 5220.3 3874.9 3991.6 4005.3 4014.0 4104.9 1242.1 1270.4 1272.4 1279.5 1286.0 966.3 984.9 985.7 988.3 993.4 6107.8 6109.7 6220.9 6237.2 6509.8 987.8 1002.5 1022.5 1043.3 1044.3 4295.3 4473.5 4480.2 4485.6 4536.9 11520.3 11960.8 11993.3 12005.3 12070.1 11395.1 11746.8 11890.8 11928.3 11948.4 8059.6 8521.3 8561.7 8624.9 8690.8 6095.7 6350.3 6463.6 6485.8 6586.5 10480.9 10913.2 10966.7 11013.4 11024.7 10405.7 10432.1 10646.5 11060.3 11125.3 8341.0 8341.5 8372.7 8462.1 8466.4 8705.8 8823.0 8833.4 8854.7 8883.6 8089.3 8149.2 8326.8 8343.8 8532.7 8121.7 8131.6 8236.2 8292.7 8455.4 7664.5 7677.5 7726.3 7727.7 7757.8 5488.5 5675.9 5744.1 5751.4 5859.6 5441.3 5468.2 5649.8 5723.2 5783.3 13:17:36 INFO - PROCESS | 30278 | 13:17:36 INFO - PROCESS | 30278 | [#4] prototype.html Cycles:180 Average:4895.16 Median:5634.30 stddev:1424.02 (25.3%) stddev-sans-first:1386.24 13:17:36 INFO - PROCESS | 30278 | Values: 333.6 345.5 351.5 354.4 356.8 5622.0 5629.8 5690.0 5709.3 5716.9 5294.0 5380.2 5403.2 5442.3 5561.6 4259.6 4266.7 4358.7 4372.4 4415.5 4377.7 4395.6 4404.8 4426.8 4426.8 4149.7 4323.5 4345.5 4353.5 4384.8 4313.8 4321.2 4325.2 4328.8 4368.1 3832.0 3832.9 3833.9 3850.0 3872.8 5229.8 5376.7 5414.7 5437.7 5442.2 4965.2 4984.1 4992.3 4994.3 5026.7 5819.5 5896.5 5915.2 5920.1 5926.8 4052.1 4184.6 4247.4 4257.9 4265.3 6059.8 6066.7 6074.1 6090.6 6110.8 4288.3 4293.6 4302.1 4302.5 4350.1 4260.4 4335.4 4345.7 4404.4 4415.1 4953.8 4980.3 4980.5 5004.3 5022.3 5847.6 5910.8 5949.9 5959.8 5973.6 1406.6 1435.5 1459.0 1502.9 1518.7 986.6 1012.5 1016.0 1025.3 1026.1 5636.9 5707.6 5709.3 5714.2 5765.5 5631.7 5921.8 5930.5 5942.4 5943.6 5623.6 5639.3 5650.7 5671.1 5687.2 3115.5 3133.7 3146.8 3162.6 3163.8 5826.7 5955.7 6001.5 6002.2 6033.0 5953.0 5961.4 5963.8 5968.6 5970.0 5821.6 6004.4 6009.2 6046.5 6089.0 5805.6 5813.6 5842.3 5858.2 5885.8 5653.6 5812.1 5824.7 5885.9 5908.0 5977.8 6007.6 6055.6 6061.3 6064.3 4264.7 4267.1 4283.0 4283.9 4296.0 5618.6 5851.8 5857.2 5915.8 5969.4 5710.9 5716.9 5741.1 5784.2 5827.3 5724.5 5728.4 5753.1 5782.6 5808.7 5390.7 5659.8 5707.4 5810.0 5818.4 5886.6 5893.3 5898.6 5919.7 5929.6 5545.9 5750.7 5760.6 5821.3 5837.2 13:17:36 INFO - PROCESS | 30278 | 13:17:36 INFO - PROCESS | 30278 | [#5] yui.html Cycles:180 Average:20851.13 Median:4291.17 stddev:28400.64 (661.8%) stddev-sans-first:28440.47 13:17:36 INFO - PROCESS | 30278 | Values: 817.7 825.5 830.8 848.9 914.1 16785.2 18319.7 18476.3 18503.1 18519.6 14601.4 16702.1 16891.0 17010.2 17076.0 853.9 874.3 876.2 876.5 879.5 876.5 877.1 879.6 880.0 880.1 922.8 930.6 931.7 932.7 932.8 923.4 923.5 924.2 924.7 924.9 680.5 682.3 682.4 682.8 682.9 14913.4 15139.5 15161.5 15210.8 15935.4 13775.9 13790.2 14027.0 14175.6 14673.0 13875.6 14069.3 14116.6 14139.6 14272.7 4658.4 4698.9 4702.4 4735.0 4841.6 70606.6 71754.3 72268.6 83919.7 90042.5 12250.1 12461.6 12731.0 12754.0 12846.3 22354.9 22546.2 22582.7 23273.8 23360.2 9529.5 9647.4 9687.3 9691.5 9832.7 5010.6 5260.4 5279.8 5330.1 5332.9 3777.0 3906.9 3914.0 3920.5 3923.9 689.9 696.4 704.4 721.4 737.0 726.2 732.6 736.5 770.0 804.3 10247.0 10262.7 10616.3 10871.3 11090.7 635.0 647.8 683.4 693.8 717.4 5197.1 5300.4 5402.5 5446.0 5482.7 68112.0 70070.6 70882.6 71000.0 140602.3 100929.0 102839.5 106969.5 107687.5 112616.0 57537.0 88840.0 91633.5 92917.5 98411.0 10194.5 10653.5 10882.4 10895.7 10960.2 50469.5 53797.5 55702.7 56646.7 57046.4 47212.0 66497.0 74739.6 76784.2 77321.0 14090.6 14211.5 14225.4 14297.8 14516.3 16367.3 16371.9 16614.8 16620.2 17833.4 14482.8 14782.4 14878.1 14926.8 15352.5 14643.7 15479.1 15510.5 15513.8 16846.2 14273.9 14369.1 14775.1 15067.2 16195.3 12439.3 12984.2 13205.3 13275.5 13596.1 12828.5 12852.0 12857.2 13077.5 13111.9 13:17:36 INFO - PROCESS | 30278 | -------- Summary: end -------- 13:17:36 INFO - PROCESS | 30278 | 13:17:36 INFO - TEST-INFO | 30278: exit 0 13:17:36 INFO - TEST-OK | dromaeo_css | took 1113495ms 13:17:36 INFO - TEST-START | kraken 13:17:36 INFO - operating with platform_type : linux_ 13:17:36 INFO - Initialising browser for kraken test... 13:17:36 INFO - TEST-INFO | started process 30596 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdihm7n/profile http://localhost:60576/getInfo.html) 13:17:40 INFO - PROCESS | 30596 | __metrics Screen width/height:1600/1200 13:17:40 INFO - PROCESS | 30596 | colorDepth:24 13:17:40 INFO - PROCESS | 30596 | Browser inner width/height: 1024/697 13:17:40 INFO - PROCESS | 30596 | __metrics 13:17:41 INFO - PROCESS | 30596 | 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" 13:17:41 INFO - PROCESS | 30596 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:17:42 INFO - PROCESS | 30596 | console.error: PushService: 13:17:42 INFO - PROCESS | 30596 | stateChangeProcessEnqueue: Error transitioning state 13:17:42 INFO - PROCESS | 30596 | UnknownError 13:17:42 INFO - TEST-INFO | 30596: exit 0 13:17:42 INFO - Browser initialized. 13:17:42 INFO - Running cycle 1/1 for kraken test... 13:17:42 INFO - TEST-INFO | started process 30689 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdihm7n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:17:54 INFO - PROCESS | 30689 | RSS: Main: 144846848 13:17:54 INFO - PROCESS | 30689 | 13:17:57 INFO - PROCESS | 30689 | Cycle 1(1): loaded http://localhost:60576/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60576/tests/kraken/driver.html?testName=audio-beat-detection) 13:17:57 INFO - PROCESS | 30689 | RSS: Main: 186114048 13:17:57 INFO - PROCESS | 30689 | 13:18:00 INFO - PROCESS | 30689 | Cycle 1(1): loaded http://localhost:60576/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60576/tests/kraken/driver.html?testName=audio-dft) 13:18:01 INFO - PROCESS | 30689 | RSS: Main: 175833088 13:18:01 INFO - PROCESS | 30689 | 13:18:03 INFO - PROCESS | 30689 | Cycle 1(1): loaded http://localhost:60576/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60576/tests/kraken/driver.html?testName=audio-fft) 13:18:04 INFO - PROCESS | 30689 | RSS: Main: 266383360 13:18:04 INFO - PROCESS | 30689 | 13:18:06 INFO - PROCESS | 30689 | Cycle 1(1): loaded http://localhost:60576/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60576/tests/kraken/driver.html?testName=audio-oscillator) 13:18:07 INFO - PROCESS | 30689 | RSS: Main: 173322240 13:18:07 INFO - PROCESS | 30689 | 13:18:09 INFO - PROCESS | 30689 | Cycle 1(1): loaded http://localhost:60576/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60576/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:18:09 INFO - PROCESS | 30689 | RSS: Main: 174284800 13:18:09 INFO - PROCESS | 30689 | 13:18:12 INFO - PROCESS | 30689 | Cycle 1(1): loaded http://localhost:60576/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60576/tests/kraken/driver.html?testName=imaging-darkroom) 13:18:13 INFO - PROCESS | 30689 | RSS: Main: 210284544 13:18:13 INFO - PROCESS | 30689 | 13:18:16 INFO - PROCESS | 30689 | Cycle 1(1): loaded http://localhost:60576/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60576/tests/kraken/driver.html?testName=imaging-desaturate) 13:18:17 INFO - PROCESS | 30689 | RSS: Main: 208580608 13:18:17 INFO - PROCESS | 30689 | 13:18:20 INFO - PROCESS | 30689 | Cycle 1(1): loaded http://localhost:60576/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60576/tests/kraken/driver.html?testName=json-parse-financial) 13:18:20 INFO - PROCESS | 30689 | RSS: Main: 209354752 13:18:20 INFO - PROCESS | 30689 | 13:18:22 INFO - PROCESS | 30689 | Cycle 1(1): loaded http://localhost:60576/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60576/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:18:22 INFO - PROCESS | 30689 | RSS: Main: 171225088 13:18:22 INFO - PROCESS | 30689 | 13:18:24 INFO - PROCESS | 30689 | Cycle 1(1): loaded http://localhost:60576/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60576/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:18:25 INFO - PROCESS | 30689 | RSS: Main: 178589696 13:18:25 INFO - PROCESS | 30689 | 13:18:27 INFO - PROCESS | 30689 | Cycle 1(1): loaded http://localhost:60576/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60576/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:18:27 INFO - PROCESS | 30689 | RSS: Main: 184492032 13:18:27 INFO - PROCESS | 30689 | 13:18:30 INFO - PROCESS | 30689 | Cycle 1(1): loaded http://localhost:60576/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60576/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:18:30 INFO - PROCESS | 30689 | RSS: Main: 184598528 13:18:30 INFO - PROCESS | 30689 | 13:18:33 INFO - PROCESS | 30689 | Cycle 1(1): loaded http://localhost:60576/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60576/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:18:34 INFO - PROCESS | 30689 | RSS: Main: 183083008 13:18:34 INFO - PROCESS | 30689 | 13:18:35 INFO - PROCESS | 30689 | Cycle 1(1): loaded http://localhost:60576/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60576/tests/kraken/driver.html?testName=ai-astar) 13:18:35 INFO - PROCESS | 30689 | RSS: Main: 233791488 13:18:35 INFO - PROCESS | 30689 | 13:18:35 INFO - PROCESS | 30689 | __start_tp_report 13:18:35 INFO - PROCESS | 30689 | _x_x_mozilla_page_load 13:18:35 INFO - PROCESS | 30689 | _x_x_mozilla_page_load_details 13:18:35 INFO - PROCESS | 30689 | |i|pagename|runs| 13:18:35 INFO - PROCESS | 30689 | |0;ai-astar;108;112;111;110;110;111;110;110;110;110 13:18:35 INFO - PROCESS | 30689 | |1;audio-beat-detection;141;124;118;150;118;120;117;123;152;123 13:18:35 INFO - PROCESS | 30689 | |2;audio-dft;161;160;161;160;163;161;161;159;161;160 13:18:35 INFO - PROCESS | 30689 | |3;audio-fft;76;76;75;110;77;77;83;76;102;76 13:18:35 INFO - PROCESS | 30689 | |4;audio-oscillator;82;81;120;82;81;82;117;81;82;107 13:18:35 INFO - PROCESS | 30689 | |5;imaging-gaussian-blur;117;116;117;116;116;117;116;117;117;116 13:18:35 INFO - PROCESS | 30689 | |6;imaging-darkroom;158;151;154;150;157;150;150;151;155;147 13:18:35 INFO - PROCESS | 30689 | |7;imaging-desaturate;94;95;95;95;95;94;94;95;95;95 13:18:35 INFO - PROCESS | 30689 | |8;json-parse-financial;50;49;49;50;49;52;49;49;48;50 13:18:35 INFO - PROCESS | 30689 | |9;json-stringify-tinderbox;59;59;59;59;60;59;58;60;59;59 13:18:35 INFO - PROCESS | 30689 | |10;stanford-crypto-aes;74;73;72;78;73;73;75;79;75;72 13:18:35 INFO - PROCESS | 30689 | |11;stanford-crypto-ccm;121;119;121;116;117;116;115;117;160;128 13:18:35 INFO - PROCESS | 30689 | |12;stanford-crypto-pbkdf2;156;151;154;151;150;148;155;152;155;153 13:18:35 INFO - PROCESS | 30689 | |13;stanford-crypto-sha256-iterative;66;63;66;62;62;63;62;61;61;60 13:18:35 INFO - PROCESS | 30689 | __end_tp_report 13:18:35 INFO - PROCESS | 30689 | __start_cc_report 13:18:35 INFO - PROCESS | 30689 | _x_x_mozilla_cycle_collect,1563 13:18:35 INFO - PROCESS | 30689 | __end_cc_report 13:18:35 INFO - PROCESS | 30689 | __startTimestamp1474921115964__endTimestamp 13:18:35 INFO - PROCESS | 30689 | 13:18:35 INFO - PROCESS | 30689 | ------- Summary: start ------- 13:18:35 INFO - PROCESS | 30689 | Number of tests: 14 13:18:35 INFO - PROCESS | 30689 | 13:18:35 INFO - PROCESS | 30689 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.00 stddev:1.03 (0.9%) stddev-sans-first:0.73 13:18:35 INFO - PROCESS | 30689 | Values: 108.0 112.0 111.0 110.0 110.0 111.0 110.0 110.0 110.0 110.0 13:18:35 INFO - PROCESS | 30689 | 13:18:35 INFO - PROCESS | 30689 | [#1] audio-beat-detection Cycles:10 Average:128.60 Median:123.50 stddev:13.65 (11.1%) stddev-sans-first:13.72 13:18:35 INFO - PROCESS | 30689 | Values: 141.0 124.0 118.0 150.0 118.0 120.0 117.0 123.0 152.0 123.0 13:18:35 INFO - PROCESS | 30689 | 13:18:35 INFO - PROCESS | 30689 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 13:18:35 INFO - PROCESS | 30689 | Values: 161.0 160.0 161.0 160.0 163.0 161.0 161.0 159.0 161.0 160.0 13:18:35 INFO - PROCESS | 30689 | 13:18:35 INFO - PROCESS | 30689 | [#3] audio-fft Cycles:10 Average:82.80 Median:76.00 stddev:12.57 (16.5%) stddev-sans-first:13.09 13:18:35 INFO - PROCESS | 30689 | Values: 76.0 76.0 75.0 110.0 77.0 77.0 83.0 76.0 102.0 76.0 13:18:35 INFO - PROCESS | 30689 | 13:18:35 INFO - PROCESS | 30689 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:81.50 stddev:16.31 (20.0%) stddev-sans-first:16.93 13:18:35 INFO - PROCESS | 30689 | Values: 82.0 81.0 120.0 82.0 81.0 82.0 117.0 81.0 82.0 107.0 13:18:35 INFO - PROCESS | 30689 | 13:18:35 INFO - PROCESS | 30689 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 13:18:35 INFO - PROCESS | 30689 | Values: 117.0 116.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 116.0 13:18:35 INFO - PROCESS | 30689 | 13:18:35 INFO - PROCESS | 30689 | [#6] imaging-darkroom Cycles:10 Average:152.30 Median:152.50 stddev:3.53 (2.3%) stddev-sans-first:3.08 13:18:35 INFO - PROCESS | 30689 | Values: 158.0 151.0 154.0 150.0 157.0 150.0 150.0 151.0 155.0 147.0 13:18:35 INFO - PROCESS | 30689 | 13:18:35 INFO - PROCESS | 30689 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 13:18:35 INFO - PROCESS | 30689 | Values: 94.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 13:18:35 INFO - PROCESS | 30689 | 13:18:35 INFO - PROCESS | 30689 | [#8] json-parse-financial Cycles:10 Average:49.50 Median:49.50 stddev:1.08 (2.2%) stddev-sans-first:1.13 13:18:35 INFO - PROCESS | 30689 | Values: 50.0 49.0 49.0 50.0 49.0 52.0 49.0 49.0 48.0 50.0 13:18:35 INFO - PROCESS | 30689 | 13:18:35 INFO - PROCESS | 30689 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 13:18:35 INFO - PROCESS | 30689 | Values: 59.0 59.0 59.0 59.0 60.0 59.0 58.0 60.0 59.0 59.0 13:18:35 INFO - PROCESS | 30689 | 13:18:35 INFO - PROCESS | 30689 | [#10] stanford-crypto-aes Cycles:10 Average:74.40 Median:74.50 stddev:2.41 (3.2%) stddev-sans-first:2.55 13:18:35 INFO - PROCESS | 30689 | Values: 74.0 73.0 72.0 78.0 73.0 73.0 75.0 79.0 75.0 72.0 13:18:35 INFO - PROCESS | 30689 | 13:18:35 INFO - PROCESS | 30689 | [#11] stanford-crypto-ccm Cycles:10 Average:123.00 Median:120.00 stddev:13.55 (11.3%) stddev-sans-first:14.35 13:18:35 INFO - PROCESS | 30689 | Values: 121.0 119.0 121.0 116.0 117.0 116.0 115.0 117.0 160.0 128.0 13:18:35 INFO - PROCESS | 30689 | 13:18:35 INFO - PROCESS | 30689 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.50 Median:153.50 stddev:2.55 (1.7%) stddev-sans-first:2.37 13:18:35 INFO - PROCESS | 30689 | Values: 156.0 151.0 154.0 151.0 150.0 148.0 155.0 152.0 155.0 153.0 13:18:35 INFO - PROCESS | 30689 | 13:18:35 INFO - PROCESS | 30689 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:62.50 stddev:2.01 (3.2%) stddev-sans-first:1.72 13:18:35 INFO - PROCESS | 30689 | Values: 66.0 63.0 66.0 62.0 62.0 63.0 62.0 61.0 61.0 60.0 13:18:35 INFO - PROCESS | 30689 | -------- Summary: end -------- 13:18:35 INFO - PROCESS | 30689 | 13:18:36 INFO - TEST-INFO | 30689: exit 0 13:18:37 INFO - TEST-OK | kraken | took 60164ms 13:18:37 INFO - SUITE-END | took 1173s 13:18:37 INFO - Completed test suite (00:19:33) 13:18:37 INFO - javascript benchmark 13:18:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3097.2566584019837, 3143.0885043337435, 3148.574942382778, 3157.0, 3191.218151552868, 5596.692181929992, 5667.5749318801045, 5685.118806584986, 5737.684427356494, 5743.081107022877, 5690.7723691052415, 5747.396523365049, 5754.971225143879, 5763.942360576393, 5795.739191736371, 5191.351081114861, 5204.739763011853, 5224.373075230958, 5260.0268950244135, 5303.787848486075, 5067.619928505358, 5284.524392804647, 5290.0477913975465, 5293.311869456965, 5322.547583455411, 5056.544910958013, 5158.845234642967, 5198.636095473299, 5256.0, 5288.15389537674, 5201.843944681666, 5311.814086506993, 5313.893722125575, 5320.627556071096, 5321.095413779628, 5131.947950670141, 5172.32759741235, 5255.500727430888, 5268.0517506848755, 5276.841694749163, 5501.174823776466, 5544.584156188302, 5548.278723765925, 5566.972165139148, 5644.604877658566, 5968.253968253968, 5976.581639285252, 5986.982213023796, 6069.271687397496, 6074.48366888815, 6120.204373431426, 6131.988221943374, 6138.69306534676, 6145.631262124287, 6155.938440615581, 5490.780368785244, 5542.0, 5577.637453565505, 5647.717614119278, 5661.405552417019, 6223.253209614875, 6243.148978574987, 6278.937210627927, 6282.1519094921605, 6283.748650053946, 5991.340952495222, 6013.428724271187, 6016.879662406727, 6021.126936594257, 6052.122442245938, 5858.677772722541, 5905.645661260252, 5961.0, 6030.728617212236, 6032.487238584682, 6070.666113363807, 6078.331383547807, 6079.756809727562, 6080.574359794772, 6101.237345331833, 6079.817605471843, 6087.54343424245, 6087.54343424245, 6095.329513753483, 6100.908486372708, 4525.52481989393, 4563.247064234431, 4602.194615942197, 4657.371254880615, 4666.603338716247, 4136.400221967858, 4150.169966006811, 4150.501939767248, 4164.5210800757695, 4167.229062623424, 5876.44173803488, 5883.588148829626, 5884.382139875252, 5884.911726324109, 5886.793962211302, 5883.235179426732, 5930.8813823723285, 5978.432048955342, 6185.443310102022, 6192.164057852132, 5700.458456446631, 5799.420057994167, 5810.041343178413, 5818.389069147678, 5843.29880414353, 5251.894962100737, 5260.605454590845, 5265.183896496049, 5268.473152684701, 5281.973590132025, 6046.244219472566, 6107.114468401968, 6201.472874805692, 6238.095476155932, 6249.281332646804, 5941.643501389757, 6024.698765061817, 6030.03519436888, 6115.757578773102, 6118.741008805849, 6282.528810339151, 6284.937150628435, 6290.0879372491645, 6294.15028971083, 6302.779402720883, 6001.849953751016, 6005.90991135142, 6006.369331220334, 6025.367336429612, 6026.7287972040485, 5815.447532484407, 5927.4665280125, 6002.189704389852, 6044.425779550936, 6073.0283154695035, 5919.6744179070565, 5958.433948774859, 5959.612625179349, 5971.731272092853, 5988.610740301867, 5910.822675319747, 5952.0, 5952.851178720567, 5970.253718285215, 5972.402759723993, 5683.090705487102, 5733.627314224562, 5792.739326730223, 5794.18881356602, 5848.0350742127075, 5970.194023806731, 5984.581079324405, 5989.550783691154, 6002.399760024137, 6018.608790428608, 5566.0, 5848.2689663792025, 5853.03424934881, 5855.795047173328, 5858.443447872445], "value": 5596.70366884183, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.462916060965, 622.9252489701237, 648.5654611410355, 650.1612919334059, 656.1076935367898, 35857.0, 38854.0, 47257.29114063288, 47717.52282477174, 48060.0, 48861.267080993726, 49228.50771492284, 49269.753651231695, 49293.50706492934, 49311.0, 9286.349955503118, 9313.906860931405, 9399.107084826965, 9439.905600944006, 9442.386244894094, 8549.700760473384, 8778.16607422297, 11026.889731102707, 11276.830847537294, 11282.605108821193, 11449.713757156096, 11508.42457877107, 11521.0, 11528.596499122532, 11529.711757206094, 11291.774164516704, 11320.547178112865, 11353.716157096056, 11364.715882102932, 11365.659030229024, 11191.2725672831, 11217.66347009591, 11231.21381503295, 11249.156313276537, 11257.099432045417, 44955.32567011497, 45270.773646131885, 45354.0, 45369.31946020779, 45443.54556454426, 3837.3668344723087, 3868.439076333944, 4097.651699605507, 4173.895652608679, 4522.6758332625495, 34651.82674086639, 35008.47487287693, 35250.0, 35260.82369588161, 35482.822585886905, 4467.486239082515, 4491.101779644052, 4500.3249512573375, 4588.357629931812, 4602.838900638495, 374437.0, 376285.0, 376435.0, 377614.0, 377805.0, 62334.0, 62633.373666263666, 62668.68665656734, 62719.059214111825, 62867.0, 40433.59566404357, 41423.7928810354, 41434.37848432276, 43683.563164368585, 68346.65826670935, 18434.0, 18606.255749770127, 18698.626027479648, 18699.158537865827, 18700.158492867853, 12888.097833151589, 13392.464301428028, 14417.711645767025, 14523.709525809636, 14530.05554638945, 20439.591208175752, 21038.36884893425, 21063.68404473934, 21767.891160544412, 22108.88945555262, 6350.682465876687, 7316.634168291671, 7350.4119670426235, 7467.551946883204, 7574.394048476109, 975.8926518083006, 1002.4436437776958, 1038.99480502597, 1046.3826342457987, 1083.859656113654, 32303.192420189684, 34448.0, 34675.65324346775, 34868.85497924589, 34987.30025399478, 1115.1357697784283, 1134.9659510214706, 1146.478352349679, 1183.4201241391656, 1252.04218772639, 16960.0, 17883.28466861337, 18045.548861278574, 18071.186796594186, 18133.637327253382, 497518.0, 503343.0, 503648.0, 504839.0, 504894.0, 63063.684681577215, 63624.36375636277, 63726.36273637297, 63746.0, 63766.36233637697, 1336.084781924385, 1388.1740364483117, 1405.6766943602825, 1440.7838824176458, 1462.7074585083026, 32760.50859237161, 36119.27761444809, 36217.275654486235, 36524.63475365212, 36608.81695591612, 53956.73021634867, 54511.72744136413, 54561.181582277095, 54573.45426545842, 54626.72686636541, 445145.0, 447650.0, 447727.0, 447914.0, 448235.0, 31190.844045779624, 32146.35707285888, 32377.190570235933, 32417.35165296728, 32536.0, 52142.47857521376, 52631.0, 52648.210276845115, 52924.735376322875, 53672.0, 43875.12249755051, 44951.775241124895, 45212.321815173455, 45236.773816130706, 46686.76656616695, 43150.78424607857, 44573.0, 45112.54887451084, 45174.77412612916, 46100.07799843917, 43687.0, 43978.0, 44795.77602111969, 44827.775861120484, 45084.77457612691, 36857.26285474329, 39683.404748929366, 40306.395404068375, 40670.186596268504, 40723.0, 29461.705382945896, 30028.699713003465, 30854.84572577123, 30961.845190773904, 32416.189595260308], "value": 21716.486479662304, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.28453499166494, 429.51035819166157, 430.4890996087784, 435.3143798517335, 441.7040582809519, 16156.596085097879, 18933.0, 20664.690029649566, 20824.583508329863, 21158.0, 18748.0, 19291.421257362268, 19402.51493712658, 19428.222871085174, 19549.609007819836, 5875.7062146892695, 6080.2399700037495, 6086.726097325609, 6090.177825993501, 6090.634561926277, 5759.193712880179, 5972.73122709477, 6001.429864162919, 6004.729787159588, 6006.7897623583185, 5724.914126288109, 5961.403859614047, 5969.343372229073, 5969.910451343233, 5975.581709280352, 5883.294004719418, 5887.8233652990475, 5914.053751399777, 5953.732082056318, 5962.04607262838, 5152.92270615941, 5187.533122018998, 5261.605379596545, 5340.172273297606, 5340.359156901197, 24277.635835462483, 24318.148864789826, 24605.0, 24682.382940426454, 24814.627780583305, 2630.973690263111, 2754.7520723135012, 3135.749140068789, 3137.905862824119, 3219.259570298821, 14976.625584360478, 15205.391784328614, 15540.689186216212, 15547.689046219126, 15929.442469513511, 1942.9611407771906, 1946.6690662587393, 1955.3840540229783, 2000.249906285143, 2000.399880035998, 52919.735401322745, 62003.689981550255, 84123.99999999939, 86270.0, 86379.0, 9800.26498012652, 10573.577056917791, 10726.731831704114, 10796.082333001626, 11650.475728592233, 14288.57134285973, 14329.283535823375, 15329.9233503834, 15376.61558461025, 15944.920275398781, 8498.045449546638, 8509.914900851036, 8815.779605509913, 8881.42270752399, 8964.32462690307, 8345.833083338299, 8351.874721879176, 8364.749057528285, 8504.362172837062, 8530.573471326408, 4718.292256161603, 4875.634327425386, 4916.262560615936, 5050.318207042076, 5180.32655754757, 2073.6060148572024, 2088.832893368527, 2095.6018356512213, 2099.0583710068126, 2133.6159491291405, 992.6624947517879, 1014.7412409835445, 1026.2816028779885, 1035.435687550287, 1069.9518521666544, 19504.70742938857, 20243.190272389234, 20249.291274805604, 20335.389938301876, 20401.0, 973.2408721197477, 994.3735446668552, 1015.746063484129, 1042.4006196437078, 1049.8372752223265, 10378.792424151474, 11102.944485277521, 11103.44482775858, 11135.220534562503, 11366.602168924048, 490567.0, 507456.0, 508903.0, 511290.0, 513259.0, 93334.53332733293, 95554.0, 98232.52651210237, 99828.99999999854, 99858.0, 1005.215931573374, 1022.0903395977585, 1039.5789705169418, 1045.994770026145, 1049.532957833772, 17184.742228866828, 17424.738628920324, 17458.73811892848, 18313.816861831212, 18445.26218951227, 43605.34591981059, 44466.3330050043, 45431.54568454273, 45780.31329530126, 45895.3115703258, 54374.184387235015, 54740.726296368266, 55274.44725552854, 56146.71926640504, 57939.13091303718, 8095.87856182146, 8498.70254541088, 8617.69838055665, 8967.820643587222, 8974.641014359353, 12607.0, 13040.804387933998, 13588.116772409761, 13770.862291376958, 13777.862221377658, 11566.768664626828, 11714.648560543197, 12082.697932551757, 12106.576269830513, 12120.151589388659, 11670.358130302915, 11712.472938717949, 11841.703957401134, 11922.642320730392, 12093.939530302292, 11589.24669896454, 11991.700207494883, 12106.213096148722, 12197.085218608463, 12227.004383925994, 8253.587320633824, 8275.751727448187, 8327.458715183493, 8345.123762005145, 8356.955380577429, 10188.541515631667, 11930.105242106703, 12084.758304833678, 12093.213941093802, 12250.081243906921], "value": 9585.21536602967, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1416.3626368134342, 1478.2904205981129, 1520.2170881995771, 1679.8488136067758, 1839.3838064248469, 7908.090569584492, 8589.09814469481, 9062.818743625123, 9375.343725939187, 9384.436933783978, 9588.904110958889, 9662.033796620335, 9674.854877176831, 9678.370905891112, 9678.758031049227, 2518.508890766301, 2541.898324067035, 2543.275166577526, 2543.898244070235, 2545.681789776278, 2520.4707011527507, 2588.676415448069, 2590.209985954283, 2592.392716515763, 2592.429665473602, 2508.5610018246734, 2521.5461216980934, 2547.1467058535413, 2547.9872600636972, 2549.1715192562397, 2429.6234083717054, 2441.060191826142, 2445.76765207305, 2463.9753602464016, 2474.9628755568683, 2397.1490121006964, 2422.0, 2426.733059363469, 2429.9149529766373, 2440.9511809763885, 9333.766655833591, 9448.149666530046, 9454.0, 9466.668666596635, 9474.431534107976, 5449.618526703132, 5651.519620832234, 5657.886842263173, 5718.370979192286, 5756.079027355645, 3736.5889752127246, 3755.3052685253315, 3762.322781899257, 3918.3142949983926, 3928.9017774555577, 1241.2118304876378, 1270.1870802686287, 1274.2481935658006, 1279.6225113591513, 1335.0854664554713, 13356.86643133566, 13373.53192638253, 13421.993350498655, 13447.86552134476, 13451.32743362828, 4740.265258884879, 4783.928241076386, 4961.751912404366, 5035.446100928895, 5115.232715092691, 10399.32404393712, 10436.739081523023, 10461.895381046092, 10462.163026957825, 10487.528061237263, 5549.639273447213, 5584.0, 5590.161475778666, 5592.384837667853, 5598.944010559842, 4172.0, 4428.7121337112985, 4463.330500424962, 4556.407667003268, 5220.295260139833, 3874.9031274217805, 3991.640752332304, 4005.2790497710107, 4014.036631208489, 4104.91790164195, 1242.1491278474275, 1270.3775150176348, 1272.408330126477, 1279.4754150798128, 1286.0, 966.3090890013674, 984.9113579777854, 985.7410713841592, 988.3081842710131, 993.4039576254189, 6107.7862274821055, 6109.663968481687, 6220.937790622126, 6237.220347456568, 6509.837254068591, 987.8123156600367, 1002.5438425516372, 1022.5091955861079, 1043.3062013760916, 1044.3055368180076, 4295.334223195409, 4473.507914129443, 4480.238359478896, 4485.573870482364, 4536.9092618148115, 11520.308781473139, 11960.760784784256, 11993.340366279765, 12005.279683219034, 12070.094742894318, 11395.145364097725, 11746.823797643043, 11890.821637675443, 11928.343941083323, 11948.402579870972, 8059.637316320663, 8521.275691566287, 8561.657533698582, 8624.870626940601, 8690.782730431663, 6095.695215239309, 6350.301466838737, 6463.57986730861, 6485.805425837232, 6586.50601204902, 10480.947595261974, 10913.23607347478, 10966.725831854268, 11013.449327533752, 11024.669259922215, 10405.687829365132, 10432.113270372103, 10646.467676616294, 11060.336379817236, 11125.276857004268, 8341.0, 8341.45780524264, 8372.66509339644, 8462.069172391155, 8466.449680770731, 8705.782355441164, 8823.029466758522, 8833.425827321204, 8854.734357969272, 8883.600237989176, 8089.312408445348, 8149.225823546753, 8326.750197494084, 8343.833123337621, 8532.744017679479, 8121.715739949073, 8131.634076466455, 8236.176382361717, 8292.709755158541, 8455.365847561581, 7664.463487555818, 7677.500962437423, 7726.3432608226685, 7727.690892364242, 7757.844843103219, 5488.506034456918, 5675.914861277167, 5744.138379243147, 5751.367349591458, 5859.589828711949, 5441.347038355423, 5468.179773034077, 5649.7740090397565, 5723.227364305765, 5783.306003279633], "value": 4943.884423347634, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.56469806902, 345.47660294653605, 351.5412386835181, 354.4258301551487, 356.84120566347985, 5622.0, 5629.831105066849, 5689.9999999999945, 5709.344290155855, 5716.8856622867515, 5293.9735301323535, 5380.192971054344, 5403.162509810985, 5442.265294185284, 5561.610687251894, 4259.63793077588, 4266.701330906838, 4358.673099517533, 4372.431583894106, 4415.492218394877, 4377.737335759864, 4395.626371758404, 4404.788683112154, 4426.756528390937, 4426.77866106695, 4149.7095203335775, 4323.5460276670965, 4345.456817897762, 4353.542877997812, 4384.8026838792175, 4313.849015284466, 4321.200577893084, 4325.199838029943, 4328.826846926119, 4368.148211098837, 3832.0419895026243, 3832.8658496952753, 3833.9424908626393, 3850.0, 3872.806359682033, 5229.790808367661, 5376.650517716336, 5414.729263536847, 5437.673739575638, 5442.210879422501, 4965.155923492979, 4984.077945580079, 4992.326035985132, 4994.275830004665, 5026.723530205837, 5819.476247137778, 5896.498797602209, 5915.1718759373725, 5920.141579470996, 5926.792562260343, 4052.1085361220485, 4184.560621134798, 4247.426597409372, 4257.934901572735, 4265.296226122686, 6059.757609695607, 6066.725987542622, 6074.149619053336, 6090.604110732833, 6110.816675499742, 4288.31386978082, 4293.570642935744, 4302.139572085595, 4302.548232435612, 4350.108227813291, 4260.4248426462655, 4335.3713711511655, 4345.739255644608, 4404.361367601679, 4415.139047885696, 4953.826616068421, 4980.252962055648, 4980.452150263468, 5004.299398084271, 5022.347094877642, 5847.619904706181, 5910.763569457259, 5949.940500594938, 5959.791407300723, 5973.551983601247, 1406.648337915521, 1435.4760512412895, 1458.9865984940714, 1502.9323680434406, 1518.7342215112312, 986.6004268271362, 1012.4785735346303, 1015.9949200254099, 1025.3437799808128, 1026.1175389165312, 5636.943630563642, 5707.6290041147195, 5709.286339207599, 5714.228579141763, 5765.4522820332, 5631.662100273997, 5921.822345329647, 5930.466258036798, 5942.376050514634, 5943.55423343251, 5623.578231632644, 5639.2668953035845, 5650.689212093293, 5671.064274394678, 5687.241687781423, 3115.454795410794, 3133.733632641251, 3146.7639927005566, 3162.6204855417036, 3163.778535502539, 5826.6795326256615, 5955.702214889238, 6001.549883758736, 6002.249718785152, 6033.0, 5952.958232309328, 5961.433663801932, 5963.79126730571, 5968.582199246011, 5970.0, 5821.621594596338, 6004.42957918997, 6009.2188015557695, 6046.54650901193, 6089.021068152868, 5805.622634528742, 5813.6221145625395, 5842.269716285465, 5858.238429004202, 5885.793997210077, 5653.632513886749, 5812.099124635688, 5824.737886795189, 5885.881682480315, 5907.9704601476715, 5977.820665380045, 6007.639541627516, 6055.576109672457, 6061.333253342041, 6064.302605200459, 4264.658827293747, 4267.125239325993, 4282.950677084134, 4283.935740963951, 4295.978520107379, 5618.634788738719, 5851.765929362778, 5857.1799948008165, 5915.792947246826, 5969.373215812451, 5710.885782284248, 5716.885662286814, 5741.110127930177, 5784.248047753765, 5827.329857066322, 5724.484796368347, 5728.396049106091, 5753.1370294456165, 5782.641079346435, 5808.722081142142, 5390.703511306916, 5659.801906933238, 5707.372189059283, 5809.970950145223, 5818.421670672421, 5886.646801191942, 5893.349862038636, 5898.554854060782, 5919.720907450748, 5929.6145750526075, 5545.944540554704, 5750.654960702204, 5760.567957403127, 5821.301443826768, 5837.153612726046], "value": 4440.886575766536, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [817.7178873288715, 825.5005721538469, 830.8172202115536, 848.8726690996351, 914.113111561544, 16785.1607419629, 18319.725204121933, 18476.260949562, 18503.0748462577, 18519.629607407845, 14601.415943362254, 16702.08138552379, 16891.0, 17010.234539445722, 17076.0, 853.850576149173, 874.2743522875998, 876.2026555834192, 876.4828751036887, 879.4942907827992, 876.5310558851016, 877.079066979672, 879.643744283563, 879.9516026618534, 880.0671288434248, 922.7831459606987, 930.6137952749601, 931.7018554062703, 932.7108596335158, 932.7854593443512, 923.4459324405336, 923.4690053219425, 924.2328867040341, 924.6809850601531, 924.8658944453084, 680.5100327764002, 682.2836022176695, 682.3619915379087, 682.8292926768308, 682.8839097353462, 14913.403463861432, 15139.54581362561, 15161.545153645407, 15210.847891521054, 15935.362585496567, 13775.862241377557, 13790.241536715477, 14027.002628442102, 14175.64560885986, 14673.046251993586, 13875.583732488041, 14069.2965351732, 14116.647083822987, 14139.575812725634, 14272.714545709132, 4658.394408726877, 4698.859034228944, 4702.435707715096, 4735.0, 4841.644339584886, 70606.64696676483, 71754.28245717529, 72268.63865680638, 83919.74120388138, 90042.54978725064, 12250.081243906743, 12461.626151215478, 12731.045171612166, 12754.0, 12846.293453860128, 22354.888225558767, 22546.21088261903, 22582.661260081113, 23273.7672623275, 23360.18239361614, 9529.475878826732, 9647.421154730739, 9687.32188746781, 9691.466969316756, 9832.655857044969, 5010.599152067826, 5260.44765299638, 5279.788808447696, 5330.120530112488, 5332.866678333073, 3777.036855601859, 3906.882793516199, 3914.0, 3920.5295364555864, 3923.941140882889, 689.8965155226756, 696.3941371007155, 704.4223736536094, 721.4120491799167, 736.9705211791468, 726.2338233164063, 732.5934106570904, 736.5323019882413, 770.0336078221795, 804.2801692485193, 10247.0, 10262.743431414125, 10616.309939853885, 10871.347719136877, 11090.667279981613, 635.0093853588417, 647.7635662982977, 683.4225079807554, 693.7675878580732, 717.3830505765038, 5197.064528384927, 5300.390455097636, 5402.486763757437, 5445.972770136124, 5482.671039737628, 68112.0, 70070.64964675144, 70882.64558677173, 71000.0, 140602.2969885144, 100929.0, 102839.4858025705, 106969.4651526753, 107687.46156269325, 112616.0, 57537.0, 88840.0, 91633.54183229042, 92917.53541232251, 98411.0, 10194.490275486345, 10653.467326633792, 10882.40146791934, 10895.727606809893, 10960.177986650873, 50469.495305047945, 53797.462025379245, 55702.72148639231, 56646.716766415906, 57046.42953570411, 47212.0, 66497.0, 74739.62630186815, 76784.2321576777, 77321.0, 14090.647733806736, 14211.50259740904, 14225.430982760574, 14297.785533216802, 14516.346764395415, 16367.263473143976, 16371.918140409221, 16614.83385166133, 16620.168991550134, 17833.37583184634, 14482.782758258845, 14782.408703651734, 14878.10731356122, 14926.776098358316, 15352.46266380716, 14643.707125857636, 15479.148646824533, 15510.534683959499, 15513.767293490833, 16846.1576921151, 14273.928630356782, 14369.13785172893, 14775.113493190443, 15067.17130557786, 16195.271212795216, 12439.315837628656, 12984.15602985803, 13205.273709946045, 13275.535356262484, 13596.11625244356, 12828.486860525474, 12852.0, 12857.228566286052, 13077.542286019943, 13111.868881311064], "value": 8154.908991605603, "unit": "score"}], "name": "dromaeo_css", "value": 7701.122785202543, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 112.0, 111.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 124.0, 118.0, 150.0, 118.0, 120.0, 117.0, 123.0, 152.0, 123.0], "value": 128.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 160.0, 163.0, 161.0, 161.0, 159.0, 161.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 110.0, 77.0, 77.0, 83.0, 76.0, 102.0, 76.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 120.0, 82.0, 81.0, 82.0, 117.0, 81.0, 82.0, 107.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 151.0, 154.0, 150.0, 157.0, 150.0, 150.0, 151.0, 155.0, 147.0], "value": 152.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 49.0, 50.0, 49.0, 52.0, 49.0, 49.0, 48.0, 50.0], "value": 49.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 60.0, 59.0, 58.0, 60.0, 59.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 72.0, 78.0, 73.0, 73.0, 75.0, 79.0, 75.0, 72.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 119.0, 121.0, 116.0, 117.0, 116.0, 115.0, 117.0, 160.0, 128.0], "value": 123.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 151.0, 154.0, 151.0, 150.0, 148.0, 155.0, 152.0, 155.0, 153.0], "value": 152.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 66.0, 62.0, 62.0, 63.0, 62.0, 61.0, 61.0, 60.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1458.3999999999999, "alertThreshold": 2.0}]} 13:18:37 INFO - Return code: 0 13:18:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:18:37 INFO - # TBPL SUCCESS # 13:18:37 INFO - Running post-action listener: _resource_record_post_action 13:18:37 INFO - [mozharness: 2016-09-26 20:18:37.304076Z] Finished run-tests step (success) 13:18:37 INFO - Running post-run listener: _resource_record_post_run 13:18:37 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 266240; Write bytes: 368340992; Read time: 40; Write time: 211840 13:18:37 INFO - TinderboxPrint: CPU usage
12.9% 13:18:37 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 40 13:18:37 INFO - TinderboxPrint: I/O write bytes / time
368,340,992 / 211,840 13:18:37 INFO - TinderboxPrint: CPU idle
8,269.0 (87.1%) 13:18:37 INFO - TinderboxPrint: CPU user
1,186.1 (12.5%) 13:18:37 INFO - TinderboxPrint: Swap in / out
0 / 0 13:18:37 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118689792; Read time: 0; Write time: 79188 13:18:37 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 262144; Write bytes: 249651200; Read time: 24; Write time: 132652 13:18:37 INFO - Running post-run listener: _upload_blobber_files 13:18:37 INFO - Blob upload gear active. 13:18:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:18:37 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:18:37 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:18:37 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:18:38 INFO - (blobuploader) - INFO - Open directory for files ... 13:18:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:18:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:18:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:18:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:18:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:18:39 INFO - (blobuploader) - INFO - Done attempting. 13:18:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:18:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:18:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:18:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:18:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:18:42 INFO - (blobuploader) - INFO - Done attempting. 13:18:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:18:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:18:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:18:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:18:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:18:43 INFO - (blobuploader) - INFO - Done attempting. 13:18:43 INFO - (blobuploader) - INFO - Iteration through files over. 13:18:43 INFO - Return code: 0 13:18:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:18:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:18:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c032e98921de4437601d01fa105ac4f00ff4dde1b84ebbd5dc2c26dc76e9d5c01859549f04797e257adbb54e79c1afc332a72376f492ddeeed543c0ff054ee86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4357abb68417bff7c4c3a2a2af95ca27a63b1eb71e4d81121ac07f39ce71b51dfbafa0dcebb8578e739551645770cca0428bdb0c1487cfe1132c0a78ed5ee4f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a027b84444f6f4a9fca61844551d9e50f79b645f594c3a21a83ecc577337c88c0b5d27eb6130f05e86acdf3a06e1df726316ca58fbdbff2737fe0af67094af91"} 13:18:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:18:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:18:43 INFO - Contents: 13:18:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c032e98921de4437601d01fa105ac4f00ff4dde1b84ebbd5dc2c26dc76e9d5c01859549f04797e257adbb54e79c1afc332a72376f492ddeeed543c0ff054ee86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4357abb68417bff7c4c3a2a2af95ca27a63b1eb71e4d81121ac07f39ce71b51dfbafa0dcebb8578e739551645770cca0428bdb0c1487cfe1132c0a78ed5ee4f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a027b84444f6f4a9fca61844551d9e50f79b645f594c3a21a83ecc577337c88c0b5d27eb6130f05e86acdf3a06e1df726316ca58fbdbff2737fe0af67094af91"} 13:18:43 INFO - Running post-run listener: copy_logs_to_upload_dir 13:18:43 INFO - Copying logs to upload dir... 13:18:43 INFO - mkdir: /builds/slave/test/build/upload/logs 13:18:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.996282 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-09-26 13:18:42.342849) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 13:18:42.346148) ========= 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=836cfdc75598d54cb747368e000001a9-1474915833.129190-622452387 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-Aurora/sha512/c032e98921de4437601d01fa105ac4f00ff4dde1b84ebbd5dc2c26dc76e9d5c01859549f04797e257adbb54e79c1afc332a72376f492ddeeed543c0ff054ee86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4357abb68417bff7c4c3a2a2af95ca27a63b1eb71e4d81121ac07f39ce71b51dfbafa0dcebb8578e739551645770cca0428bdb0c1487cfe1132c0a78ed5ee4f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a027b84444f6f4a9fca61844551d9e50f79b645f594c3a21a83ecc577337c88c0b5d27eb6130f05e86acdf3a06e1df726316ca58fbdbff2737fe0af67094af91"} build_url:https://queue.taskcluster.net/v1/task/e-zwRMXWRUauU4vu4aLIXA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011504 build_url: 'https://queue.taskcluster.net/v1/task/e-zwRMXWRUauU4vu4aLIXA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c032e98921de4437601d01fa105ac4f00ff4dde1b84ebbd5dc2c26dc76e9d5c01859549f04797e257adbb54e79c1afc332a72376f492ddeeed543c0ff054ee86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4357abb68417bff7c4c3a2a2af95ca27a63b1eb71e4d81121ac07f39ce71b51dfbafa0dcebb8578e739551645770cca0428bdb0c1487cfe1132c0a78ed5ee4f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a027b84444f6f4a9fca61844551d9e50f79b645f594c3a21a83ecc577337c88c0b5d27eb6130f05e86acdf3a06e1df726316ca58fbdbff2737fe0af67094af91"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 13:18:42.375916) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 13:18:42.376702) ========= 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=836cfdc75598d54cb747368e000001a9-1474915833.129190-622452387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004681 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 13:18:42.461706) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 13:18:42.462321) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 13:18:42.466151) ========= ========= Total master_lag: 0.19 =========