builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-024 starttime: 1477355680.93 results: success (0) buildid: 20161024141422 builduid: e5f1982dda5a4e5aadd09b918805f2e6 revision: 89651cd49e8bd5d0256fefaeb281f7125fb790fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 17:34:40.927222) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 17:34:40.927790) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 17:34:40.928083) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 17:34:40.943422) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:34:40.943849) ========= 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=41a7e32711b8e08598a63237000001d6-1477355680.274963-1024987003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-24 17:34:40-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.2M=0s 2016-10-24 17:34:41 (67.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094491 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:34:41.052477) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:34:41.052808) ========= 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=41a7e32711b8e08598a63237000001d6-1477355680.274963-1024987003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018110 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:34:41.102320) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-24 17:34:41.102687) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 89651cd49e8bd5d0256fefaeb281f7125fb790fa --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 89651cd49e8bd5d0256fefaeb281f7125fb790fa --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=41a7e32711b8e08598a63237000001d6-1477355680.274963-1024987003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-24 17:34:41,195 truncating revision to first 12 chars 2016-10-24 17:34:41,195 Setting DEBUG logging. 2016-10-24 17:34:41,195 attempt 1/10 2016-10-24 17:34:41,196 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/89651cd49e8b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-24 17:34:41,835 unpacking tar archive at: mozilla-aurora-89651cd49e8b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.071915 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-24 17:34:42.188337) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 17:34:42.188677) ========= script_repo_revision: 89651cd49e8bd5d0256fefaeb281f7125fb790fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 17:34:42.189098) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 17:34:42.189390) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 17:34:42.199352) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-10-24 17:34:42.199973) ========= /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=41a7e32711b8e08598a63237000001d6-1477355680.274963-1024987003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:34:42 INFO - MultiFileLogger online at 20161024 17:34:42 in /builds/slave/test 17:34:42 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 17:34:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:34:42 INFO - {'append_to_log': False, 17:34:42 INFO - 'base_work_dir': '/builds/slave/test', 17:34:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:34:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:34:42 INFO - 'branch': 'Mozilla-Aurora', 17:34:42 INFO - 'buildbot_json_path': 'buildprops.json', 17:34:42 INFO - 'config_files': ('talos/linux_config.py',), 17:34:42 INFO - 'default_actions': ('clobber', 17:34:42 INFO - 'read-buildbot-config', 17:34:42 INFO - 'download-and-extract', 17:34:42 INFO - 'populate-webroot', 17:34:42 INFO - 'create-virtualenv', 17:34:42 INFO - 'install', 17:34:42 INFO - 'run-tests'), 17:34:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:34:42 INFO - 'download_minidump_stackwalk': True, 17:34:42 INFO - 'download_symbols': 'ondemand', 17:34:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:34:42 INFO - 'tooltool.py': '/tools/tooltool.py', 17:34:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:34:42 INFO - '/tools/misc-python/virtualenv.py')}, 17:34:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:34:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:34:42 INFO - 'installer_path': 'installer.exe', 17:34:42 INFO - 'log_level': 'info', 17:34:42 INFO - 'log_name': 'talos', 17:34:42 INFO - 'log_to_console': True, 17:34:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:34:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:34:42 INFO - 'opt_config_files': (), 17:34:42 INFO - 'pip_index': False, 17:34:42 INFO - 'sps_profile': False, 17:34:42 INFO - 'sps_profile_interval': 0, 17:34:42 INFO - 'suite': 'dromaeojs', 17:34:42 INFO - 'system_bits': '32', 17:34:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:34:42 INFO - 'title': 'talos-linux64-ix-024', 17:34:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:34:42 INFO - 'use_talos_json': True, 17:34:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:34:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:34:42 INFO - 'work_dir': 'build'} 17:34:42 INFO - [mozharness: 2016-10-25 00:34:42.391635Z] Running clobber step. 17:34:42 INFO - Running pre-action listener: _resource_record_pre_action 17:34:42 INFO - Running main action method: clobber 17:34:42 INFO - rmtree: /builds/slave/test/build 17:34:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:34:43 INFO - Running post-action listener: _resource_record_post_action 17:34:43 INFO - [mozharness: 2016-10-25 00:34:43.351963Z] Finished clobber step (success) 17:34:43 INFO - [mozharness: 2016-10-25 00:34:43.352064Z] Running read-buildbot-config step. 17:34:43 INFO - Running pre-action listener: _resource_record_pre_action 17:34:43 INFO - Running main action method: read_buildbot_config 17:34:43 INFO - Using buildbot properties: 17:34:43 INFO - { 17:34:43 INFO - "project": "", 17:34:43 INFO - "product": "firefox", 17:34:43 INFO - "script_repo_revision": "production", 17:34:43 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 17:34:43 INFO - "repository": "", 17:34:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 17:34:43 INFO - "buildid": "20161024141422", 17:34:43 INFO - "pgo_build": "True", 17:34:43 INFO - "basedir": "/builds/slave/test", 17:34:43 INFO - "buildnumber": 832, 17:34:43 INFO - "slavename": "talos-linux64-ix-024", 17:34:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:34:43 INFO - "platform": "ubuntu64_hw", 17:34:43 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 17:34:43 INFO - "branch": "mozilla-aurora", 17:34:43 INFO - "repo_path": "releases/mozilla-aurora", 17:34:43 INFO - "revision": "89651cd49e8bd5d0256fefaeb281f7125fb790fa", 17:34:43 INFO - "stage_platform": "linux64-pgo", 17:34:43 INFO - "builduid": "e5f1982dda5a4e5aadd09b918805f2e6", 17:34:43 INFO - "slavebuilddir": "test" 17:34:43 INFO - } 17:34:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/TtKKmwt6Q3GTL0On12R00Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 17:34:43 INFO - Running post-action listener: _resource_record_post_action 17:34:43 INFO - [mozharness: 2016-10-25 00:34:43.354515Z] Finished read-buildbot-config step (success) 17:34:43 INFO - [mozharness: 2016-10-25 00:34:43.354604Z] Running download-and-extract step. 17:34:43 INFO - Running pre-action listener: _resource_record_pre_action 17:34:43 INFO - Running main action method: download_and_extract 17:34:43 INFO - mkdir: /builds/slave/test/build/tests 17:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:43 INFO - trying https://queue.taskcluster.net/v1/task/TtKKmwt6Q3GTL0On12R00Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 17:34:43 INFO - Downloading https://queue.taskcluster.net/v1/task/TtKKmwt6Q3GTL0On12R00Q/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 17:34:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TtKKmwt6Q3GTL0On12R00Q/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 17:34:43 INFO - Downloaded 1361 bytes. 17:34:43 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 17:34:43 INFO - Using the following test package requirements: 17:34:43 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 17:34:43 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 17:34:43 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 17:34:43 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 17:34:43 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 17:34:43 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 17:34:43 INFO - u'jsshell-linux-x86_64.zip'], 17:34:43 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 17:34:43 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 17:34:43 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 17:34:43 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 17:34:43 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 17:34:43 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 17:34:43 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 17:34:43 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 17:34:43 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 17:34:43 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 17:34:43 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 17:34:43 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:34:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TtKKmwt6Q3GTL0On12R00Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 17:34:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TtKKmwt6Q3GTL0On12R00Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:34:43 INFO - Fetch https://queue.taskcluster.net/v1/task/TtKKmwt6Q3GTL0On12R00Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 17:34:44 INFO - Expected file size: 21910273 17:34:48 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 17:34:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TtKKmwt6Q3GTL0On12R00Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 17:34:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TtKKmwt6Q3GTL0On12R00Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:34:48 INFO - Fetch https://queue.taskcluster.net/v1/task/TtKKmwt6Q3GTL0On12R00Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 17:34:49 INFO - Expected file size: 21910273 17:34:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TtKKmwt6Q3GTL0On12R00Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 17:34:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TtKKmwt6Q3GTL0On12R00Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:34:54 INFO - Fetch https://queue.taskcluster.net/v1/task/TtKKmwt6Q3GTL0On12R00Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 17:34:54 INFO - Expected file size: 14414081 17:34:55 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')]} 17:34:55 INFO - trying https://queue.taskcluster.net/v1/task/TtKKmwt6Q3GTL0On12R00Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 17:34:55 INFO - Downloading https://queue.taskcluster.net/v1/task/TtKKmwt6Q3GTL0On12R00Q/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 17:34:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TtKKmwt6Q3GTL0On12R00Q/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 17:34:56 INFO - Downloaded 63994487 bytes. 17:34:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TtKKmwt6Q3GTL0On12R00Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 17:34:56 INFO - mkdir: /builds/slave/test/properties 17:34:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:34:56 INFO - Writing to file /builds/slave/test/properties/build_url 17:34:56 INFO - Contents: 17:34:56 INFO - build_url:https://queue.taskcluster.net/v1/task/TtKKmwt6Q3GTL0On12R00Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 17:34:57 INFO - Running post-action listener: _resource_record_post_action 17:34:57 INFO - Running post-action listener: set_extra_try_arguments 17:34:57 INFO - [mozharness: 2016-10-25 00:34:57.056022Z] Finished download-and-extract step (success) 17:34:57 INFO - [mozharness: 2016-10-25 00:34:57.056248Z] Running populate-webroot step. 17:34:57 INFO - Running pre-action listener: _resource_record_pre_action 17:34:57 INFO - Running main action method: populate_webroot 17:34:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:34:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:34:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:34:57 INFO - '--tppagecycles', 17:34:57 INFO - '7'], 17:34:57 INFO - 'tests': ['tsvgm']}}, 17:34:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:34:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:34:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:34:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:34:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:34:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:34:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:57 INFO - 'talos_options': ['--disable-e10s'], 17:34:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:34:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:34:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:57 INFO - 'talos_options': ['--disable-e10s'], 17:34:57 INFO - 'tests': ['damp', 'tps']}, 17:34:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:57 INFO - 'tests': ['damp', 'tps']}, 17:34:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:34:57 INFO - 'tests': ['dromaeo_dom']}, 17:34:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:34:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:34:57 INFO - 'tests': ['basic_compositor_video']}, 17:34:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:34:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:34:57 INFO - 'tests': ['a11yr', 17:34:57 INFO - 'ts_paint', 17:34:57 INFO - 'tpaint', 17:34:57 INFO - 'sessionrestore', 17:34:57 INFO - 'sessionrestore_no_auto_restore', 17:34:57 INFO - 'tabpaint']}, 17:34:57 INFO - 'other-e10s': {'tests': ['a11yr', 17:34:57 INFO - 'ts_paint', 17:34:57 INFO - 'tpaint', 17:34:57 INFO - 'sessionrestore', 17:34:57 INFO - 'sessionrestore_no_auto_restore', 17:34:57 INFO - 'tabpaint']}, 17:34:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:34:57 INFO - 'ts_paint', 17:34:57 INFO - 'tpaint', 17:34:57 INFO - 'sessionrestore', 17:34:57 INFO - 'sessionrestore_no_auto_restore', 17:34:57 INFO - 'tabpaint']}, 17:34:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:34:57 INFO - 'ts_paint', 17:34:57 INFO - 'tpaint', 17:34:57 INFO - 'sessionrestore', 17:34:57 INFO - 'sessionrestore_no_auto_restore', 17:34:57 INFO - 'tabpaint']}, 17:34:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:34:57 INFO - 'tests': ['a11yr', 17:34:57 INFO - 'ts_paint', 17:34:57 INFO - 'tpaint', 17:34:57 INFO - 'sessionrestore', 17:34:57 INFO - 'sessionrestore_no_auto_restore', 17:34:57 INFO - 'tabpaint']}, 17:34:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:34:57 INFO - 'tests': ['a11yr', 17:34:57 INFO - 'ts_paint', 17:34:57 INFO - 'tpaint', 17:34:57 INFO - 'sessionrestore', 17:34:57 INFO - 'sessionrestore_no_auto_restore', 17:34:57 INFO - 'tabpaint']}, 17:34:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:34:57 INFO - 'tests': ['tsvgx', 17:34:57 INFO - 'tsvgr_opacity', 17:34:57 INFO - 'tart', 17:34:57 INFO - 'tscrollx', 17:34:57 INFO - 'cart']}, 17:34:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:34:57 INFO - 'tsvgr_opacity', 17:34:57 INFO - 'tart', 17:34:57 INFO - 'tscrollx', 17:34:57 INFO - 'cart']}, 17:34:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:57 INFO - 'talos_options': ['--disable-e10s'], 17:34:57 INFO - 'tests': ['tp5o']}, 17:34:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:57 INFO - 'tests': ['tp5o']}, 17:34:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:57 INFO - 'talos_options': ['--disable-e10s', 17:34:57 INFO - '--xperf_path', 17:34:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:34:57 INFO - 'tests': ['tp5n']}, 17:34:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:57 INFO - 'talos_options': ['--xperf_path', 17:34:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:34:57 INFO - 'tests': ['tp5n']}}, 17:34:57 INFO - 'talos.zip': {'path': '', 17:34:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:34:57 INFO - Running post-action listener: _resource_record_post_action 17:34:57 INFO - [mozharness: 2016-10-25 00:34:57.075669Z] Finished populate-webroot step (success) 17:34:57 INFO - [mozharness: 2016-10-25 00:34:57.075756Z] Running create-virtualenv step. 17:34:57 INFO - Running pre-action listener: _resource_record_pre_action 17:34:57 INFO - Running main action method: create_virtualenv 17:34:57 INFO - Creating virtualenv /builds/slave/test/build/venv 17:34:57 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 17:34:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:34:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:34:57 INFO - Using real prefix '/usr' 17:34:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:34:57 INFO - Installing distribute.............................................................................................................................................................................................done. 17:34:59 INFO - Installing pip.................done. 17:34:59 INFO - Return code: 0 17:34:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:59 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 0x7fbe59591f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c75f60>, '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 0x1c76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c771d0>, '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': '41a7e32711b8e08598a63237000001d6-1477355680.274963-1024987003', '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 17:34:59 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 17:34:59 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 17:34:59 INFO - Using env: {'DISPLAY': ':0', 17:34:59 INFO - 'HOME': '/home/cltbld', 17:34:59 INFO - 'LANG': 'en_US.UTF-8', 17:34:59 INFO - 'LANGUAGE': 'en_US:en', 17:34:59 INFO - 'LOGNAME': 'cltbld', 17:34:59 INFO - 'MAIL': '/var/mail/cltbld', 17:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:59 INFO - 'MOZ_NO_REMOTE': '1', 17:34:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:59 INFO - 'NO_EM_RESTART': '1', 17:34:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:59 INFO - 'PWD': '/builds/slave/test', 17:34:59 INFO - 'SHELL': '/bin/bash', 17:34:59 INFO - 'SHLVL': '1', 17:34:59 INFO - 'TERM': 'linux', 17:34:59 INFO - 'TMOUT': '86400', 17:34:59 INFO - 'USER': 'cltbld', 17:34:59 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477355680.274963-1024987003', 17:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:59 INFO - '_': '/tools/buildbot/bin/python'} 17:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:59 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 17:34:59 INFO - Cleaning up... 17:34:59 INFO - Return code: 0 17:34:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:59 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 0x7fbe59591f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c75f60>, '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 0x1c76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c771d0>, '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': '41a7e32711b8e08598a63237000001d6-1477355680.274963-1024987003', '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 17:34:59 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 17:34:59 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 17:34:59 INFO - Using env: {'DISPLAY': ':0', 17:34:59 INFO - 'HOME': '/home/cltbld', 17:34:59 INFO - 'LANG': 'en_US.UTF-8', 17:34:59 INFO - 'LANGUAGE': 'en_US:en', 17:34:59 INFO - 'LOGNAME': 'cltbld', 17:34:59 INFO - 'MAIL': '/var/mail/cltbld', 17:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:59 INFO - 'MOZ_NO_REMOTE': '1', 17:34:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:59 INFO - 'NO_EM_RESTART': '1', 17:34:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:59 INFO - 'PWD': '/builds/slave/test', 17:34:59 INFO - 'SHELL': '/bin/bash', 17:34:59 INFO - 'SHLVL': '1', 17:34:59 INFO - 'TERM': 'linux', 17:34:59 INFO - 'TMOUT': '86400', 17:34:59 INFO - 'USER': 'cltbld', 17:34:59 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477355680.274963-1024987003', 17:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:59 INFO - '_': '/tools/buildbot/bin/python'} 17:35:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:00 INFO - Downloading/unpacking psutil>=3.1.1 17:35:00 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 17:35:00 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 17:35:00 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 17:35:00 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 17:35:00 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 17:35:00 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 17:35:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:35:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:35:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:35:02 INFO - Installing collected packages: psutil 17:35:02 INFO - Running setup.py install for psutil 17:35:02 INFO - building 'psutil._psutil_linux' extension 17:35:02 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 17:35:02 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 17:35:02 INFO - building 'psutil._psutil_posix' extension 17:35:02 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 17:35:02 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 17:35:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:35:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:35:02 INFO - Successfully installed psutil 17:35:02 INFO - Cleaning up... 17:35:02 INFO - Return code: 0 17:35:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:35:02 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')]} 17:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:02 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')]} 17:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:02 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 0x7fbe59591f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c75f60>, '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 0x1c76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c771d0>, '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': '41a7e32711b8e08598a63237000001d6-1477355680.274963-1024987003', '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 17:35:02 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 17:35:02 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 17:35:02 INFO - Using env: {'DISPLAY': ':0', 17:35:02 INFO - 'HOME': '/home/cltbld', 17:35:02 INFO - 'LANG': 'en_US.UTF-8', 17:35:02 INFO - 'LANGUAGE': 'en_US:en', 17:35:02 INFO - 'LOGNAME': 'cltbld', 17:35:02 INFO - 'MAIL': '/var/mail/cltbld', 17:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:02 INFO - 'MOZ_NO_REMOTE': '1', 17:35:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:02 INFO - 'NO_EM_RESTART': '1', 17:35:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:02 INFO - 'PWD': '/builds/slave/test', 17:35:02 INFO - 'SHELL': '/bin/bash', 17:35:02 INFO - 'SHLVL': '1', 17:35:02 INFO - 'TERM': 'linux', 17:35:02 INFO - 'TMOUT': '86400', 17:35:02 INFO - 'USER': 'cltbld', 17:35:02 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477355680.274963-1024987003', 17:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:02 INFO - '_': '/tools/buildbot/bin/python'} 17:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:35:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:35:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:35:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:35:04 INFO - Installing collected packages: mozsystemmonitor 17:35:04 INFO - Running setup.py install for mozsystemmonitor 17:35:04 INFO - Successfully installed mozsystemmonitor 17:35:04 INFO - Cleaning up... 17:35:05 INFO - Return code: 0 17:35:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:35:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:05 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 0x7fbe59591f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c75f60>, '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 0x1c76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c771d0>, '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': '41a7e32711b8e08598a63237000001d6-1477355680.274963-1024987003', '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 17:35:05 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 17:35:05 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 17:35:05 INFO - Using env: {'DISPLAY': ':0', 17:35:05 INFO - 'HOME': '/home/cltbld', 17:35:05 INFO - 'LANG': 'en_US.UTF-8', 17:35:05 INFO - 'LANGUAGE': 'en_US:en', 17:35:05 INFO - 'LOGNAME': 'cltbld', 17:35:05 INFO - 'MAIL': '/var/mail/cltbld', 17:35:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:05 INFO - 'MOZ_NO_REMOTE': '1', 17:35:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:05 INFO - 'NO_EM_RESTART': '1', 17:35:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:05 INFO - 'PWD': '/builds/slave/test', 17:35:05 INFO - 'SHELL': '/bin/bash', 17:35:05 INFO - 'SHLVL': '1', 17:35:05 INFO - 'TERM': 'linux', 17:35:05 INFO - 'TMOUT': '86400', 17:35:05 INFO - 'USER': 'cltbld', 17:35:05 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477355680.274963-1024987003', 17:35:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:05 INFO - '_': '/tools/buildbot/bin/python'} 17:35:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:05 INFO - Downloading/unpacking jsonschema==2.5.1 17:35:05 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 17:35:05 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 17:35:05 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 17:35:05 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 17:35:05 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 17:35:05 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 17:35:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:35:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:35:07 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 17:35:07 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 17:35:07 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 17:35:07 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 17:35:07 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 17:35:07 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 17:35:07 INFO - Downloading functools32-3.2.3-2.tar.gz 17:35:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:35:07 INFO - warning: no files found matching '*.txt' 17:35:07 INFO - no previously-included directories found matching 'build' 17:35:07 INFO - no previously-included directories found matching 'dist' 17:35:07 INFO - no previously-included directories found matching '.git*' 17:35:07 INFO - Installing collected packages: jsonschema, functools32 17:35:07 INFO - Running setup.py install for functools32 17:35:07 INFO - warning: no files found matching '*.txt' 17:35:07 INFO - no previously-included directories found matching 'build' 17:35:07 INFO - no previously-included directories found matching 'dist' 17:35:07 INFO - no previously-included directories found matching '.git*' 17:35:07 INFO - Successfully installed jsonschema functools32 17:35:07 INFO - Cleaning up... 17:35:07 INFO - Return code: 0 17:35:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:07 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 0x7fbe59591f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c75f60>, '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 0x1c76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c771d0>, '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': '41a7e32711b8e08598a63237000001d6-1477355680.274963-1024987003', '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 17:35:07 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 17:35:07 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 17:35:07 INFO - Using env: {'DISPLAY': ':0', 17:35:07 INFO - 'HOME': '/home/cltbld', 17:35:07 INFO - 'LANG': 'en_US.UTF-8', 17:35:07 INFO - 'LANGUAGE': 'en_US:en', 17:35:07 INFO - 'LOGNAME': 'cltbld', 17:35:07 INFO - 'MAIL': '/var/mail/cltbld', 17:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:07 INFO - 'MOZ_NO_REMOTE': '1', 17:35:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:07 INFO - 'NO_EM_RESTART': '1', 17:35:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:07 INFO - 'PWD': '/builds/slave/test', 17:35:07 INFO - 'SHELL': '/bin/bash', 17:35:07 INFO - 'SHLVL': '1', 17:35:07 INFO - 'TERM': 'linux', 17:35:07 INFO - 'TMOUT': '86400', 17:35:07 INFO - 'USER': 'cltbld', 17:35:07 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477355680.274963-1024987003', 17:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:07 INFO - '_': '/tools/buildbot/bin/python'} 17:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:35:07 INFO - Cleaning up... 17:35:07 INFO - Return code: 0 17:35:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:07 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 0x7fbe59591f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c75f60>, '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 0x1c76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c771d0>, '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': '41a7e32711b8e08598a63237000001d6-1477355680.274963-1024987003', '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 17:35:07 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 17:35:07 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 17:35:07 INFO - Using env: {'DISPLAY': ':0', 17:35:07 INFO - 'HOME': '/home/cltbld', 17:35:07 INFO - 'LANG': 'en_US.UTF-8', 17:35:07 INFO - 'LANGUAGE': 'en_US:en', 17:35:07 INFO - 'LOGNAME': 'cltbld', 17:35:07 INFO - 'MAIL': '/var/mail/cltbld', 17:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:07 INFO - 'MOZ_NO_REMOTE': '1', 17:35:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:07 INFO - 'NO_EM_RESTART': '1', 17:35:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:07 INFO - 'PWD': '/builds/slave/test', 17:35:07 INFO - 'SHELL': '/bin/bash', 17:35:07 INFO - 'SHLVL': '1', 17:35:07 INFO - 'TERM': 'linux', 17:35:07 INFO - 'TMOUT': '86400', 17:35:07 INFO - 'USER': 'cltbld', 17:35:07 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477355680.274963-1024987003', 17:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:07 INFO - '_': '/tools/buildbot/bin/python'} 17:35:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:08 INFO - Downloading/unpacking blobuploader==1.2.4 17:35:08 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 17:35:08 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 17:35:08 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 17:35:08 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 17:35:08 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 17:35:08 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 17:35:09 INFO - Downloading blobuploader-1.2.4.tar.gz 17:35:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:35:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:35:10 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 17:35:10 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 17:35:10 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 17:35:10 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 17:35:10 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 17:35:10 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 17:35:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:35:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:35:10 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 17:35:10 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 17:35:10 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 17:35:10 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 17:35:10 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 17:35:10 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 17:35:10 INFO - Downloading docopt-0.6.1.tar.gz 17:35:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:35:10 INFO - Installing collected packages: blobuploader, requests, docopt 17:35:10 INFO - Running setup.py install for blobuploader 17:35:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:35:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:35:10 INFO - Running setup.py install for requests 17:35:11 INFO - Running setup.py install for docopt 17:35:11 INFO - Successfully installed blobuploader requests docopt 17:35:11 INFO - Cleaning up... 17:35:11 INFO - Return code: 0 17:35:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35: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')]} 17:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35: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')]} 17:35:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:11 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 0x7fbe59591f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c75f60>, '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 0x1c76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c771d0>, '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': '41a7e32711b8e08598a63237000001d6-1477355680.274963-1024987003', '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 17:35:11 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 17:35:11 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 17:35:11 INFO - Using env: {'DISPLAY': ':0', 17:35:11 INFO - 'HOME': '/home/cltbld', 17:35:11 INFO - 'LANG': 'en_US.UTF-8', 17:35:11 INFO - 'LANGUAGE': 'en_US:en', 17:35:11 INFO - 'LOGNAME': 'cltbld', 17:35:11 INFO - 'MAIL': '/var/mail/cltbld', 17:35:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:11 INFO - 'MOZ_NO_REMOTE': '1', 17:35:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:11 INFO - 'NO_EM_RESTART': '1', 17:35:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:11 INFO - 'PWD': '/builds/slave/test', 17:35:11 INFO - 'SHELL': '/bin/bash', 17:35:11 INFO - 'SHLVL': '1', 17:35:11 INFO - 'TERM': 'linux', 17:35:11 INFO - 'TMOUT': '86400', 17:35:11 INFO - 'USER': 'cltbld', 17:35:11 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477355680.274963-1024987003', 17:35:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:11 INFO - '_': '/tools/buildbot/bin/python'} 17:35:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:35:11 INFO - Running setup.py (path:/tmp/pip-Drz7iZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:35:11 INFO - Running setup.py (path:/tmp/pip-egG9me-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:35:11 INFO - Running setup.py (path:/tmp/pip-U0afFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:35:11 INFO - Running setup.py (path:/tmp/pip-wQDxcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:35:11 INFO - Running setup.py (path:/tmp/pip-Il3PlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:35:11 INFO - Running setup.py (path:/tmp/pip-IZg5TK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:35:12 INFO - Running setup.py (path:/tmp/pip-YLNJ4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:35:12 INFO - Running setup.py (path:/tmp/pip-SbcCcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:35:12 INFO - Running setup.py (path:/tmp/pip-nngMAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:35:12 INFO - Running setup.py (path:/tmp/pip-vfMCIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:35:12 INFO - Running setup.py (path:/tmp/pip-tNHFaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:35:12 INFO - Running setup.py (path:/tmp/pip-CvUWad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:35:12 INFO - Running setup.py (path:/tmp/pip-YJHt55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:35:12 INFO - Running setup.py (path:/tmp/pip-GG1ekc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:12 INFO - Running setup.py (path:/tmp/pip-KMkhVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:35:12 INFO - Running setup.py (path:/tmp/pip-iMztX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:35:12 INFO - Running setup.py (path:/tmp/pip-R5zFtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:35:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:35:12 INFO - Running setup.py install for manifestparser 17:35:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:35:12 INFO - Running setup.py install for mozcrash 17:35:13 INFO - Running setup.py install for mozdebug 17:35:13 INFO - Running setup.py install for mozdevice 17:35:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:35:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:35:13 INFO - Running setup.py install for mozfile 17:35:13 INFO - Running setup.py install for mozhttpd 17:35:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:35:13 INFO - Running setup.py install for mozinfo 17:35:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:35:13 INFO - Running setup.py install for mozInstall 17:35:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:35:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:35:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:35:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:35:13 INFO - Running setup.py install for mozleak 17:35:13 INFO - Running setup.py install for mozlog 17:35:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:35:13 INFO - Running setup.py install for moznetwork 17:35:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:35:13 INFO - Running setup.py install for mozprocess 17:35:14 INFO - Running setup.py install for mozprofile 17:35:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:35:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:35:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:35:14 INFO - Running setup.py install for mozrunner 17:35:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:35:14 INFO - Running setup.py install for mozscreenshot 17:35:14 INFO - Running setup.py install for moztest 17:35:14 INFO - Running setup.py install for mozversion 17:35:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:35:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:35:14 INFO - Cleaning up... 17:35:14 INFO - Return code: 0 17:35:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35:14 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')]} 17:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:14 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')]} 17:35:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:14 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 0x7fbe59591f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c75f60>, '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 0x1c76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c771d0>, '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': '41a7e32711b8e08598a63237000001d6-1477355680.274963-1024987003', '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 17:35:14 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 17:35:14 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 17:35:14 INFO - Using env: {'DISPLAY': ':0', 17:35:14 INFO - 'HOME': '/home/cltbld', 17:35:14 INFO - 'LANG': 'en_US.UTF-8', 17:35:14 INFO - 'LANGUAGE': 'en_US:en', 17:35:14 INFO - 'LOGNAME': 'cltbld', 17:35:14 INFO - 'MAIL': '/var/mail/cltbld', 17:35:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:14 INFO - 'MOZ_NO_REMOTE': '1', 17:35:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:14 INFO - 'NO_EM_RESTART': '1', 17:35:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:14 INFO - 'PWD': '/builds/slave/test', 17:35:14 INFO - 'SHELL': '/bin/bash', 17:35:14 INFO - 'SHLVL': '1', 17:35:14 INFO - 'TERM': 'linux', 17:35:14 INFO - 'TMOUT': '86400', 17:35:14 INFO - 'USER': 'cltbld', 17:35:14 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477355680.274963-1024987003', 17:35:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:14 INFO - '_': '/tools/buildbot/bin/python'} 17:35:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:35:14 INFO - Running setup.py (path:/tmp/pip-0UVygU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:35:14 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)) 17:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:35:14 INFO - Running setup.py (path:/tmp/pip-cTJC5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:35:14 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)) 17:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:35:14 INFO - Running setup.py (path:/tmp/pip-BBwDDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:35:15 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)) 17:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:35:15 INFO - Running setup.py (path:/tmp/pip-52wVL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:35:15 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)) 17:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:35:15 INFO - Running setup.py (path:/tmp/pip-Fg9wse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:35:15 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)) 17:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:35:15 INFO - Running setup.py (path:/tmp/pip-NHg4Zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:35:15 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)) 17:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:35:15 INFO - Running setup.py (path:/tmp/pip-ChTg_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:35:15 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)) 17:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:35:15 INFO - Running setup.py (path:/tmp/pip-oya7VC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:35:15 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)) 17:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:35:15 INFO - Running setup.py (path:/tmp/pip-yIZWAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:35:15 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)) 17:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:35:15 INFO - Running setup.py (path:/tmp/pip-6s9Z_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:35:15 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)) 17:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:35:15 INFO - Running setup.py (path:/tmp/pip-IcLbGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:35:15 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)) 17:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:35:15 INFO - Running setup.py (path:/tmp/pip-pggqgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:35:15 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)) 17:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:35:15 INFO - Running setup.py (path:/tmp/pip-LDmBSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:35:15 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)) 17:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:35:15 INFO - Running setup.py (path:/tmp/pip-M3ZKqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:35:15 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)) 17:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:15 INFO - Running setup.py (path:/tmp/pip-2AXbOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:15 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)) 17:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:35:15 INFO - Running setup.py (path:/tmp/pip-GAyNgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:35:16 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)) 17:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:35:16 INFO - Running setup.py (path:/tmp/pip-Jjl_ok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:35:16 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)) 17:35:16 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)) 17:35:16 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)) 17:35:16 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)) 17:35:16 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)) 17:35:16 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)) 17:35:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:35:16 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 17:35:16 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 17:35:16 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 17:35:16 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 17:35:16 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 17:35:16 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 17:35:17 INFO - Downloading blessings-1.6.tar.gz 17:35:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:35:18 INFO - Installing collected packages: blessings 17:35:18 INFO - Running setup.py install for blessings 17:35:18 INFO - Successfully installed blessings 17:35:18 INFO - Cleaning up... 17:35:18 INFO - Return code: 0 17:35:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:35:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:35:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:35:18 INFO - Reading from file tmpfile_stdout 17:35:18 INFO - Current package versions: 17:35:18 INFO - argparse == 1.2.1 17:35:18 INFO - blessings == 1.6 17:35:18 INFO - blobuploader == 1.2.4 17:35:18 INFO - docopt == 0.6.1 17:35:18 INFO - functools32 == 3.2.3-2 17:35:18 INFO - jsonschema == 2.5.1 17:35:18 INFO - manifestparser == 1.1 17:35:18 INFO - mozInstall == 1.12 17:35:18 INFO - mozcrash == 0.17 17:35:18 INFO - mozdebug == 0.1 17:35:18 INFO - mozdevice == 0.48 17:35:18 INFO - mozfile == 1.2 17:35:18 INFO - mozhttpd == 0.7 17:35:18 INFO - mozinfo == 0.9 17:35:18 INFO - mozleak == 0.1 17:35:18 INFO - mozlog == 3.4 17:35:18 INFO - moznetwork == 0.27 17:35:18 INFO - mozprocess == 0.23 17:35:18 INFO - mozprofile == 0.28 17:35:18 INFO - mozrunner == 6.12 17:35:18 INFO - mozscreenshot == 0.1 17:35:18 INFO - mozsystemmonitor == 0.3 17:35:18 INFO - moztest == 0.7 17:35:18 INFO - mozversion == 1.4 17:35:18 INFO - psutil == 3.1.1 17:35:18 INFO - requests == 1.2.3 17:35:18 INFO - wsgiref == 0.1.2 17:35:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:18 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 0x7fbe59591f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c75f60>, '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 0x1c76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c771d0>, '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': '41a7e32711b8e08598a63237000001d6-1477355680.274963-1024987003', '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 17:35:18 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 17:35:18 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 17:35:18 INFO - Using env: {'DISPLAY': ':0', 17:35:18 INFO - 'HOME': '/home/cltbld', 17:35:18 INFO - 'LANG': 'en_US.UTF-8', 17:35:18 INFO - 'LANGUAGE': 'en_US:en', 17:35:18 INFO - 'LOGNAME': 'cltbld', 17:35:18 INFO - 'MAIL': '/var/mail/cltbld', 17:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:18 INFO - 'MOZ_NO_REMOTE': '1', 17:35:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:18 INFO - 'NO_EM_RESTART': '1', 17:35:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:18 INFO - 'PWD': '/builds/slave/test', 17:35:18 INFO - 'SHELL': '/bin/bash', 17:35:18 INFO - 'SHLVL': '1', 17:35:18 INFO - 'TERM': 'linux', 17:35:18 INFO - 'TMOUT': '86400', 17:35:18 INFO - 'USER': 'cltbld', 17:35:18 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477355680.274963-1024987003', 17:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:18 INFO - '_': '/tools/buildbot/bin/python'} 17:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:18 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)) 17:35:18 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)) 17:35:18 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)) 17:35:18 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)) 17:35:18 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)) 17:35:18 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)) 17:35:18 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)) 17:35:18 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)) 17:35:18 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)) 17:35:18 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)) 17:35:18 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)) 17:35:18 INFO - Cleaning up... 17:35:18 INFO - Return code: 0 17:35:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe59591f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c78ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c75f60>, '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 0x1c76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c771d0>, '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': '41a7e32711b8e08598a63237000001d6-1477355680.274963-1024987003', '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 17:35:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:35:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:35:18 INFO - Using env: {'DISPLAY': ':0', 17:35:18 INFO - 'HOME': '/home/cltbld', 17:35:18 INFO - 'LANG': 'en_US.UTF-8', 17:35:18 INFO - 'LANGUAGE': 'en_US:en', 17:35:18 INFO - 'LOGNAME': 'cltbld', 17:35:18 INFO - 'MAIL': '/var/mail/cltbld', 17:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:18 INFO - 'MOZ_NO_REMOTE': '1', 17:35:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:18 INFO - 'NO_EM_RESTART': '1', 17:35:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:18 INFO - 'PWD': '/builds/slave/test', 17:35:18 INFO - 'SHELL': '/bin/bash', 17:35:18 INFO - 'SHLVL': '1', 17:35:18 INFO - 'TERM': 'linux', 17:35:18 INFO - 'TMOUT': '86400', 17:35:18 INFO - 'USER': 'cltbld', 17:35:18 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477355680.274963-1024987003', 17:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:18 INFO - '_': '/tools/buildbot/bin/python'} 17:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:35:18 INFO - Cleaning up... 17:35:18 INFO - Return code: 0 17:35:18 INFO - Running post-action listener: _resource_record_post_action 17:35:18 INFO - Running post-action listener: _start_resource_monitoring 17:35:18 INFO - Starting resource monitoring. 17:35:18 INFO - [mozharness: 2016-10-25 00:35:18.957807Z] Finished create-virtualenv step (success) 17:35:18 INFO - [mozharness: 2016-10-25 00:35:18.958373Z] Running install step. 17:35:18 INFO - Running pre-action listener: _resource_record_pre_action 17:35:18 INFO - Running main action method: install 17:35:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:35:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:35:19 INFO - Reading from file tmpfile_stdout 17:35:19 INFO - Detecting whether we're running mozinstall >=1.0... 17:35:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:35:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:35:19 INFO - Reading from file tmpfile_stdout 17:35:19 INFO - Output received: 17:35:19 INFO - Usage: mozinstall [options] installer 17:35:19 INFO - Options: 17:35:19 INFO - -h, --help show this help message and exit 17:35:19 INFO - -d DEST, --destination=DEST 17:35:19 INFO - Directory to install application into. [default: 17:35:19 INFO - "/builds/slave/test"] 17:35:19 INFO - --app=APP Application being installed. [default: firefox] 17:35:19 INFO - mkdir: /builds/slave/test/build/application 17:35:19 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'] 17:35:19 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 17:35:35 INFO - Reading from file tmpfile_stdout 17:35:35 INFO - Output received: 17:35:35 INFO - /builds/slave/test/build/application/firefox/firefox 17:35:35 INFO - Running post-action listener: _resource_record_post_action 17:35:35 INFO - [mozharness: 2016-10-25 00:35:35.212412Z] Finished install step (success) 17:35:35 INFO - [mozharness: 2016-10-25 00:35:35.212658Z] Running run-tests step. 17:35:35 INFO - Running pre-action listener: _resource_record_pre_action 17:35:35 INFO - Running main action method: run_tests 17:35:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:35:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:35:35 INFO - Python 2.7.3 17:35:35 INFO - Return code: 0 17:35:35 INFO - grabbing minidump binary from tooltool 17:35: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')]} 17:35:35 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 0x1c75f60>, '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 0x1c76d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c771d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:35:35 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 17:35:35 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 17:35:35 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 17:35:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:35:35 INFO - Return code: 0 17:35:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:35:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:35:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:35:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:35:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:35:35 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/TtKKmwt6Q3GTL0On12R00Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 17:35:35 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/TtKKmwt6Q3GTL0On12R00Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 17:35:35 INFO - Using env: {'DISPLAY': ':0', 17:35:35 INFO - 'HOME': '/home/cltbld', 17:35:35 INFO - 'LANG': 'en_US.UTF-8', 17:35:35 INFO - 'LANGUAGE': 'en_US:en', 17:35:35 INFO - 'LOGNAME': 'cltbld', 17:35:35 INFO - 'MAIL': '/var/mail/cltbld', 17:35:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:35:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:35:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:35 INFO - 'MOZ_NO_REMOTE': '1', 17:35:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:35:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:35 INFO - 'NO_EM_RESTART': '1', 17:35:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:35 INFO - 'PWD': '/builds/slave/test', 17:35:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:35:35 INFO - 'SHELL': '/bin/bash', 17:35:35 INFO - 'SHLVL': '1', 17:35:35 INFO - 'TERM': 'linux', 17:35:35 INFO - 'TMOUT': '86400', 17:35:35 INFO - 'USER': 'cltbld', 17:35:35 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477355680.274963-1024987003', 17:35:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:35 INFO - '_': '/tools/buildbot/bin/python'} 17:35:35 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/TtKKmwt6Q3GTL0On12R00Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 17:35:35 INFO - mozversion application_buildid: 20161024141422 17:35:35 INFO - mozversion application_changeset: 89651cd49e8bd5d0256fefaeb281f7125fb790fa 17:35:35 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:35:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:35:35 INFO - mozversion application_name: Firefox 17:35:35 INFO - mozversion application_remotingname: firefox-dev 17:35:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:35:35 INFO - mozversion application_vendor: Mozilla 17:35:35 INFO - mozversion application_version: 51.0a2 17:35:35 INFO - mozversion platform_buildid: 20161024141422 17:35:35 INFO - mozversion platform_changeset: 89651cd49e8bd5d0256fefaeb281f7125fb790fa 17:35:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:35:35 INFO - mozversion platform_version: 51.0a2 17:35:35 INFO - using testdate: 1477355735 17:35:35 INFO - actual date: 1477355735 17:35:35 INFO - starting webserver on 'localhost:34180' 17:35:35 INFO - SUITE-START | Running 2 tests 17:35:35 INFO - TEST-START | dromaeo_css 17:35:35 INFO - operating with platform_type : linux_ 17:35:35 INFO - Initialising browser for dromaeo_css test... 17:35:35 INFO - TEST-INFO | started process 28810 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmnlC_G/profile http://localhost:34180/getInfo.html) 17:35:39 INFO - PROCESS | 28810 | __metrics Screen width/height:1600/1200 17:35:39 INFO - PROCESS | 28810 | colorDepth:24 17:35:39 INFO - PROCESS | 28810 | Browser inner width/height: 1024/697 17:35:39 INFO - PROCESS | 28810 | __metrics 17:35:40 INFO - PROCESS | 28810 | 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" 17:35:40 INFO - PROCESS | 28810 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:35:40 INFO - PROCESS | 28810 | console.error: PushService: 17:35:40 INFO - PROCESS | 28810 | stateChangeProcessEnqueue: Error transitioning state 17:35:40 INFO - PROCESS | 28810 | UnknownError 17:35:41 INFO - TEST-INFO | 28810: exit 0 17:35:41 INFO - Browser initialized. 17:35:41 INFO - Running cycle 1/1 for dromaeo_css test... 17:35:41 INFO - TEST-INFO | started process 28900 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmnlC_G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:35:52 INFO - PROCESS | 28900 | RSS: Main: 143855616 17:35:52 INFO - PROCESS | 28900 | 17:36:44 INFO - PROCESS | 28900 | 1477355804246 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] 17:38:53 INFO - PROCESS | 28900 | Cycle 1(1): loaded http://localhost:34180/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34180/tests/dromaeo/cssquery-ext.html) 17:38:54 INFO - PROCESS | 28900 | RSS: Main: 238510080 17:38:54 INFO - PROCESS | 28900 | 17:41:56 INFO - PROCESS | 28900 | Cycle 1(1): loaded http://localhost:34180/tests/dromaeo/cssquery-ext.html (next: http://localhost:34180/tests/dromaeo/cssquery-jquery.html) 17:41:57 INFO - PROCESS | 28900 | RSS: Main: 232103936 17:41:57 INFO - PROCESS | 28900 | 17:44:59 INFO - PROCESS | 28900 | Cycle 1(1): loaded http://localhost:34180/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34180/tests/dromaeo/cssquery-mootools.html) 17:44:59 INFO - PROCESS | 28900 | RSS: Main: 223858688 17:44:59 INFO - PROCESS | 28900 | 17:48:01 INFO - PROCESS | 28900 | Cycle 1(1): loaded http://localhost:34180/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34180/tests/dromaeo/cssquery-prototype.html) 17:48:02 INFO - PROCESS | 28900 | RSS: Main: 175431680 17:48:02 INFO - PROCESS | 28900 | 17:51:04 INFO - PROCESS | 28900 | Cycle 1(1): loaded http://localhost:34180/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34180/tests/dromaeo/cssquery-yui.html) 17:51:05 INFO - PROCESS | 28900 | RSS: Main: 176926720 17:51:05 INFO - PROCESS | 28900 | 17:54:08 INFO - PROCESS | 28900 | Cycle 1(1): loaded http://localhost:34180/tests/dromaeo/cssquery-yui.html (next: http://localhost:34180/tests/dromaeo/cssquery-dojo.html) 17:54:08 INFO - PROCESS | 28900 | RSS: Main: 264306688 17:54:08 INFO - PROCESS | 28900 | 17:54:08 INFO - PROCESS | 28900 | __start_tp_report 17:54:08 INFO - PROCESS | 28900 | _x_x_mozilla_page_load 17:54:08 INFO - PROCESS | 28900 | _x_x_mozilla_page_load_details 17:54:08 INFO - PROCESS | 28900 | |i|pagename|runs| 17:54:08 INFO - PROCESS | 28900 | |0;dojo.html;3155.1481100102974;3185.8088514689107;3190.5373720810485;3207.16613680443;3227.951580726288;5622.044252477079;5640.323161220655;5665.5467562594995;5666.631668941516;5707.229524014257;5639.210510528529;5692.089265717486;5694.943050569493;5697.572682048853;5734.627249228808;5118.667286626367;5132.717700526469;5143.27994080829;5164.92252616211;5205.843824685247;5022.874428139289;5222.033923724123;5223.085959957011;5224;5232.293640358541;5015.7492125393765;5074.822381216658;5090.0328937501945;5117.616178786588;5155.871103222431;5138.948610513903;5165.225216217578;5166.43169251382;5222.216667499867;5228.215767634847;5086.491350864884;5115.693058416507;5186.818461353834;5201.245819356172;5229.137192363255;5424.674519528801;5439.428859969726;5497.45025497451;5508.531774799147;5568.248286481314;5921.851953701149;5935.317438494585;6009.06859436788;6017.187679663277;6026.126211699323;6065.605735627214;6071.483923866476;6072.089186621998;6083.209182806251;6083.270007599072;5428.4300148484235;5472.26124473195;5557.472040156219;5594.916076258859;5609.439056094439;6178.382161783786;6193.256809182837;6201.627902325875;6209.565330426917;6213.937860621336;5924.674142922181;5936.940630593639;5937.287525496968;5944.524438044946;5951.315598706117;5829.650220986669;5889.587728858939;5942.613730107616;5967.8209653710455;5971.790987315423;6016.608920420159;6038.064100064497;6041.184440100618;6050.183225264533;6077.301110372276;6008.729607167688;6061.636301821904;6074.271087469532;6077.058056001327;6100.786472473531;4523.751193684313;4529.116822219701;4536.02475467776;4575.633949284049;4667.113248482778;4057.9391309129796;4063.654589359878;4065.5324637667045;4099.098198396348;4101.97949010259;5638.04153293941;5646.830595082154;5667.886642267132;5672.064109421982;5676.489115979582;5870.941290587125;5931.6441013539325;5954.225950626391;5954.255718035246;5962.2249107615735;5668;5706.001449746361;5713.028785106542;5759.769609215668;5792.623479473821;5250.501202385767;5260.263563101169;5261.394939581997;5267;5290.365156181283;6020.277566692025;6166.9383306167265;6186.288576813724;6210.285817131088;6230.906536401958;5954.19618351517;6029.51763858899;6075.149479072845;6082.057281121433;6144.341027922525;6291.559590828598;6297.118403423433;6303.180586523723;6304.022876454157;6308.842278943063;6011.398860113954;6018.2778066630535;6022.1870047543025;6027.819165425044;6038;5823.35943046273;5841.299044114733;5991.700414979321;6041.69791510414;6043.848903777441;5977.581569290108;6015.187949626745;6015.518758499222;6017.247844019497;6019.789307374221;6007.068904319837;6007.87984240304;6019.668918209365;6022.759089636541;6025.728842202024;5733;5763.855903602276;5812.476877081083;5864.970675146597;5926.081457373942;5949.91075133882;5958.6424814511265;5963.73163207648;5978.581499295007;5996.640201587918;5676.403977582295;5807.361190269152;5811.041178205718;5814.273215848019;5825.300963884191 17:54:08 INFO - PROCESS | 28900 | |1;ext.html;599.5173885022558;620.392015824492;644.7711062572789;651.6188030002447;652.7747926965195;34014.82992585037;38252.61747382525;46062.53937460625;46907.765461172734;47105;47928;48281.27578086332;48350.51649483504;48380;48428.51571484284;9307.255419566436;9466.290028247875;9476.336656434052;9479.573419196153;9482.573284202228;8577.785555361104;8798.780030499225;10947.890521094767;11176.720581985433;11189.384583847885;11379.886201137966;11497.597584084559;11498.885011149865;11499;11499.712507187303;11308.37803920784;11374.37440940748;11386.601468948547;11390.316581005125;11392.601258955896;11075.612353567667;11135.33188008722;11145.609903653332;11154.498047587878;11162.553497860075;45090.32364514535;45200.09599807985;45370.31944520835;45398.31902521432;45424.3186352205;3771.9057023574355;3862.1889403225355;3863.497745293094;4016.5180178378782;4147.875563733093;34402.82798585991;34532.309353813034;34570.827145864365;34946.30107397863;35048.12379690503;4445.1331990261915;4473.552644735533;4502.6172775314135;4532.637389008872;4588.26587745959;354447;357976;359454;359815;359907;37966.24067518634;61599;61619.691901541104;61703.38296617066;62004.37995620076;38961;39494.80252598719;39726.40410393846;39748.80125599354;39774.60225397709;16487.258073386725;16510;16519.91740041292;16574.585635359213;16584.336626534805;11758.5884494044;11761;14746.852531474548;14916.477923272634;14918.776218356734;9245.3528253023;9474.526273686288;9485.715428537154;9622.566984485715;9728.513574321256;3657.122290650225;3693.353663108945;3704.7406681532034;3718.981405092957;3734.4605668145377;1035.2080658296409;1074.6131392698621;1078.8456351703758;1084.6637542361734;1167.5329868052677;34713.65286347104;35035.64964350375;35340.64659353425;35382.64617353845;35524.28951421009;1183.9704007399712;1209.1233855454725;1240.237254088747;1242.9813552796534;1277.7189018415934;17278.459018021247;17962.751388216788;18103.72844407335;18320.633587328444;18340.633187336178;591182;593536;595899;598001;598143;62602;63176;63326.0501092484;63359;63382;1295.436485128972;1351.8310211223597;1399.657084014423;1423.4021710881455;1443.949461768833;33814;35312.646873531965;35518.289634207686;35804.462933056544;36021.27957440889;46109.769451152526;46242.76878615585;46258.768706156254;46314.53685463102;46351;422445;423757;423897;424770;427026;30275.24311892132;31755.841220793747;31846;33144.50283245801;33249;51132.233016505525;51201.74399127981;51337;51855.481445186575;52402.21396679129;43204.78397607992;44094;44519.44181953616;44763.55236447724;45600.54399455963;44074.77962610166;44635.553644463136;45222.32166517439;45691.77154114208;46076.7696161517;43462.56537434585;44177.55822441863;44513.55486445094;44672.776636116614;44790.55209447864;35482.29035419329;38530.74134304091;38783;39446.60553394429;39696.206075877744;29264.56103158497;29651.703482964895;29762.851185743933;29923.850380747957;29927.850360748056 17:54:08 INFO - PROCESS | 28900 | |2;jquery.html;399.6003996003996;435.12105546795476;439.7708405008003;440.15270604087135;452.4864279043287;17314.82685173148;19085.14116864741;20832.270870519536;21465.67801482975;21723.13107475699;19602.41192764216;19616.803831961675;20385.694214586794;20857.26999555016;20920.163193472243;5754.309482862062;5797.304323481178;6013.368596297391;6014.368491308415;6016.0975853622085;5831.708414579275;5842.32813226478;5892.558058145635;5892.823215303548;5918.99377105893;5655.57583181261;5848.766049358021;5850.619709718854;5861.736221870005;5864.618799778023;5859.355470898197;5903.35063143054;5905.9409405906035;5906.26171728534;5911.586188966752;5312.468753124656;5338.866528336784;5346.331708536433;5565.777368905239;5624.3813180550105;22537.43656408603;23254.186103486467;23400.765992340028;23965.40086497834;24366.756332436627;2449.7917676997477;2608.5565453872887;2618.450125473653;2668.2795645175693;2925.502664547032;10569.524371403306;10673.573057077707;10728.839067413996;10832.241743077988;10924.2899211551;2034.3185033013958;2107.115011695076;2123.904424300895;2129.233475948657;2152.2251989283845;76424.23575764227;77665;77723;87323.56338218332;90702.09297907069;10531.157507399543;11734.530618775325;11753.118516111155;11781.528738850522;12113.39433028345;15628.843711562966;15709.764353534707;16504.092274924995;16559.503214903572;17162.39931602388;8760.12398760119;8809.911900880908;8882.245009174163;8960.05919378469;9035.45787252767;8527.678209877478;8585.484870907765;8902.376833621714;8959.23846473044;9213.95393023044;5130.999455106218;5173.456787037307;5197.8440646780655;5199.66202196856;5279.947200528022;2069.2343832781967;2070.9171633134806;2112.704221409004;2136.6688163334707;2160.1143531152466;997.6109317366233;1044.0186224948525;1060.7454210989306;1067.5356220044305;1090.6782499162766;19440.805591944183;20246.59506809885;20382.796172038088;20421.489462763253;20856.58286834255;988.3575675810637;999.4902599674218;1028.711960651019;1057.471264367816;1064.2709743825349;10901.52829368041;10939.28894621847;11869.762604747857;11894.762104757856;12366.567170149001;541962;545867;552475;555667;555788;92728;93866.53066734623;100720.49639751755;106584.46707766411;107097.46451267693;1057.381431862369;1067.0609863320228;1094.4363652718855;1095.5070218401752;1099.6151347028635;18469.353572624892;18744.718829217847;18850.905745471733;19026.714599280745;19398.8060119397;41979.37030944599;43579.56420435755;44926;45301.546984529734;46488.90799913945;55939;56630.716846415504;62951;63327;64708.67645661742;6852.5545839522265;8286.70996515119;8302.045264794626;8814.250788682777;9013.639454422011;12689.4289756963;13024.609261722164;13045.412956416794;13222.4049917752;13240.40418181165;11502.194846360675;11527.538898444303;11709.824352634547;12093.33486658207;12227.082968777555;11139.665810025712;11402.600908968147;11505.769884602429;11626.941865290619;11769.705757356134;11734.94132529332;11791.705207369541;11855.644330670093;12072.75854482923;12226.755464890475;8381;8663.263622591898;8716.825663486821;8752.081031491602;9074.637014519609;11066.667999960015;11832.940835295769;11855.162449820291;11994.400279986141;12151.331676757864 17:54:08 INFO - PROCESS | 28900 | |3;mootools.html;1438.3383643523978;1561.4300780215221;1582.9920850395747;1694.161390111895;1781;8259.132791056934;8899.510526921016;9202.769930751727;9221.58502867371;9522.000189980055;9247.445153290808;9353.579088940996;9355.578998945046;9359.48522831244;9375.6718514852;2524.192258477288;2557.1689201009654;2557.181701855407;2562.090457887451;2564.6922369315707;2423.1882319423016;2529.0389651932333;2537.949241015179;2542.275451496324;2543.669322988009;2486.627005949104;2511.309389917769;2571.112966026718;2577.9613305800335;2578.3940773918116;2485.3662316109458;2500.8874600643016;2513.42191296002;2540.187140115164;2540.352210186409;2504.211173480348;2504.2862784106624;2512.836665616729;2514.622806579028;2541.783948364391;9237.815243695088;9361.204297634642;9593.808123837554;9711.805763884682;9739.56171972263;5730.36965933747;5996.880062398727;6001.369856165127;6007.459328660441;6009.57932944694;3644.5808731995894;3810.161764411825;3816.656500914931;3854.9036274093373;3859.3824988002066;1288.0532808385829;1288.375138058041;1290.6708789258773;1320.7886738121854;1328.8604696506825;13788.793168102486;13830.37763300654;13881.652958676013;13928.094673846168;13936;4946.431160416598;5158.664686795346;5189.11784996544;5209.166533354645;5273.2617433559335;10603;10603;10603.522841472151;10630.574777008833;10640.148788096934;5737.512311453574;5740.1102829061565;5744.712764361765;5746.5402767779315;5749.108888122348;4397;4557.156925968707;4752.2158843790385;4768.7615619218905;5331.280277162534;4208.494980602286;4277.893052673708;4362.629176519968;4384.101259241847;4393.362962370438;1281.1672412931669;1281.2440660010639;1296.5138073222543;1316.3681432912256;1321.359140816703;935.0784138595117;988.8763904511936;1047.6699839550517;1055.9155267578576;1055.9683209503728;6366.586171898812;6492.5455218134275;6576.309487503743;6630.734770609218;6677.031830384567;491.2017970797454;495.0742112250043;497.54971750565795;1057.8783439904355;1089.199438412766;4441.311596702516;4564.950061485811;4570.7257564546235;4627.67606267558;4645.465771436328;11669.299842009506;12039.458224379923;12067.75864482723;12068.517259309529;12074.758504829853;11297;11813.40932953366;11819.231749936227;12051.939740301417;12166.756664866652;8842.867356989651;8997.145271199226;9023.819523609622;9074;9080.364374493722;6202.317745047951;6466.773662921775;6530.771423000172;6534.052562378333;6549.24683661385;10461.790764184825;10755.677329680122;10776.29954052984;10867.728306792393;10973.835392469278;9906.356086854332;10263.281570290306;11006.174536909924;11106.16703747206;11129.83305250438;8265;8378.287845533197;8420.452670576393;8469;8704.129587041245;9319.906800931903;9369.109934556207;9384.624615015324;9385.108414700593;9401.435913845191;8137;8364.247217750431;8402.159784021549;8453.619587118472;8461.746147615582;8095.595220239083;8122.675092996214;8136.1863813618165;8258.628361723617;8365.205305495969;7581.469297149147;7661.655225514976;7665.885011724717;7750.689972401041;7769.650365733442;5533.889322213453;5535.916961245504;5598.944010559842;5606.18710286998;5695.060315047971;5437.32033495813;5452.991196628636;5492.835214943399;5535.750891209825;5552.416996215339 17:54:08 INFO - PROCESS | 28900 | |4;prototype.html;355.417115929875;358.4784139077642;361.7323180846175;362.7533277371387;369.0533780852116;5532.419095994923;5545.504522964667;5554.72226388681;5568.7215639217975;5582.302212223472;5498.642588231762;5499.395066542677;5519.641223320481;5525.392206857253;5542.528885044766;4157.833686652538;4270.636995855356;4325.243082460573;4334.5882141196535;4347.152615037156;4328.350747387885;4329.523752387235;4331.956680433203;4338.652907767387;4345.630621397185;4297.806598703066;4300.440942677463;4307.806148723299;4316.352547117926;4325.264705000158;4144.6529877789835;4297.39836422901;4305.138972205556;4305.827766889321;4318.69769116162;3798.3542797724454;3804.9809750951345;3815.2560250751117;3821.675157611606;3822.445745366906;5361.919571206435;5379.273798037254;5382.192671099367;5382.434844341327;5409.486098820606;4786.7845946932475;4870.464248932614;4937.1732458990045;4957.5786058185095;4979.825706100305;5720.256366672347;5729.169270455761;5730.512906402961;5733.856653583652;5740.397258287861;4164.729292596002;4188.769617671027;4191.580841915784;4220.556841531657;4226.619604235603;5890.499307558863;5911.349751527328;5952.1964534787685;5954.166416701665;5989.670568118751;4271.654428854963;4275.294576394922;4278.08021275421;4282.207791558571;4291.334843099325;4323.783810809447;4336.349547567827;4345.9348109778375;4347.239233134252;4367.388565600819;4748.50703380721;4926.9014619707405;4965.577925876269;4971.1549036663855;4980.252962055721;5802.854928626818;5803.6807975560905;5805.912911306334;5815.214945982323;5836.8540786479825;1493.4772829509584;1512.9319180636899;1518.3395223077996;1521.1329542161084;1524.3445318512925;917.7430319510547;958.8445922663174;960.1790469148917;967.2842096848282;977.9853501786201;4895.877603059952;4898.240772680169;4906.067847109038;4915.311856340115;4919.450373132452;5139.408967968731;5153.716545589954;5185.948140518622;5207.54188827129;5207.557357624644;4628.004978929546;4860.465348811628;4875.780589873464;4908.809273971947;4916.360873086476;2765.6681198256338;2767.6125342452074;2768.29408500831;2769.487644785721;2778.388754474053;5304.867378315573;5309.522143007148;5313.734313284398;5326.893462130735;5330.466953304638;5296.576273898079;5363.731813409314;5694.9430505695245;5799.942000580025;6151.876962460726;5994.250718660168;6013.9699301503215;6132.264128304543;6151.9384806151365;6162.938370616326;5957.434043765836;5974.970125149346;5982.4316689914385;6001.99900049975;6014.368491308524;5673.687947162945;5913.70431478433;5924.9703751480965;5945.927039977629;5970.880582388241;6106.847328816815;6115.755369785336;6138.416850399205;6202.193714817045;6204.844878878064;4116.608922152391;4220.556841531595;4263.808128634157;4266.232078225949;4304.246756817607;5842.152887831326;5907.586468947133;5919.378465261258;5919.408059194218;5925.496332811759;5759.9136012959;5783.710814459344;5784.050134431386;5791.507721843691;5806.767729290781;5662.320521537442;5786.07422812348;5799.4780469757925;5800.738966746591;5823.970880145572;5770.297762160257;5786.537077033743;5792.913106303325;5795.304563452412;5821.185034095315;5584.553235741049;5826.300843898759;5837.708114594168;5839.211706419749;5863.648181109147;5649.180868774087;5657.773689052557;5669.603127781016;5688.5733569981585;5718.142278658234 17:54:08 INFO - PROCESS | 28900 | |5;yui.html;841.4824882697139;859.1151114352217;859.5444414460338;892.977675558111;914.5655813488598;13779.655508612277;14292.71414571708;14401.20793356365;14404.927975360108;14469.059511131769;14830.332635031422;14836.554903352917;14911.10533367996;15005;15007.324670389831;841.0874201491389;870.316801310971;871.3551971541045;871.6949067826242;871.7689812199773;728.3663213004667;747.114669117098;832.0389949608182;860.3934226370425;867.6009035843488;909.8680691299791;914.6387177065055;916.7708072981754;916.839553078212;919.2186641354829;912.5574096563162;912.7307444303947;914.1589737441536;914.7484441778531;915.4644532948166;553.6346011632303;566.1055532259021;644.5423749138117;659.0410952064782;664.6776313487954;14608.926955365261;14649.267536623127;14659.560213193621;14676.339564719614;14717.55847324582;14037.368318425695;14385.568432947028;14551.490697825526;14684.559463216014;14855.108693478425;13651.453941842314;13671.794923076162;13818;14016;14097.78853317201;4571.839985600488;4633.652476064275;4639.512851150648;4731.053789242131;4738.64460165489;87236.56381718114;89094.55452722759;89554;91857;93729.53135234349;11817.527298908119;12114.21257618252;12240.877591223974;12314.692132696755;12480.75038499243;21684.24105156312;23469.647955280685;23634.17280395178;23673.526529469313;23751.881240594033;8860.911390886009;8963.417377870548;9001.684941027033;9156.816863662823;9239.076092390842;4969.652124351333;5169.81905633301;5193.922091168635;5228.9477105229225;5323.653962492425;3820.9044773880873;3911.471951286597;3943.5662077171487;3960.148568057881;3976.4035394691027;680.8706345794283;688.2257460357098;689.2797027106685;692.8164036530324;698.800841760096;748.6144635512716;799.9000124984377;805.3476683886071;806.9314108300861;820.5404973215019;10829.24195306321;10864.402457864735;11080.61217857371;11169.664910052712;11172.776544469227;686.3308274432488;695.2908033805592;724.6340597997977;737.1154614462666;750.339701063061;5079.517445842639;5371.865703357369;5391.110466772939;5395.21769343443;5447.618666693294;121778;127422.36288818682;128493;130117.34941325423;135036.3248183753;89766.55116724374;112560;113322;116916.41541792237;117925;72979;100059.49970250102;100818.49590751853;101129.49435252776;101472.49263753781;9649.582503581103;10135.7466063349;10167.898321016992;10190.847137292798;10191.184705223712;49615.503844962535;58428.415715844;58606;59823.40176598352;61973.690131549054;49814.00371992467;65734.67132664306;70227.31472925497;70985.29014709787;73154.26845731474;14420.278986050866;14552.272386380428;14614.415423382945;14652.706945861237;14860.256987150384;15563;15776.60558486047;16564.668706626042;16565.337386504885;17834;13728.794068088788;14077.225752583707;14833.258337083318;14955.32701028478;15273.770893436385;14222.644433889236;14228.430862765374;14369.64075898111;14739.778903316244;15197.93614446978;14212.92893535567;14251.643708906946;14693.412263509339;14783.113013219241;15078.698426031637;12264.325462099314;13060.542880999119;13295.534656286984;13665.590032298649;13717.382717777924;12966.546170883974;13049.804252936403;13215.405306761026;13262.204267743966;13356.422673864812 17:54:08 INFO - PROCESS | 28900 | __end_tp_report 17:54:08 INFO - PROCESS | 28900 | __start_cc_report 17:54:08 INFO - PROCESS | 28900 | _x_x_mozilla_cycle_collect,860 17:54:08 INFO - PROCESS | 28900 | __end_cc_report 17:54:08 INFO - PROCESS | 28900 | __startTimestamp1477356848397__endTimestamp 17:54:08 INFO - PROCESS | 28900 | 17:54:08 INFO - PROCESS | 28900 | ------- Summary: start ------- 17:54:08 INFO - PROCESS | 28900 | Number of tests: 6 17:54:08 INFO - PROCESS | 28900 | 17:54:08 INFO - PROCESS | 28900 | [#0] dojo.html Cycles:165 Average:5602.87 Median:5823.36 stddev:647.46 (11.1%) stddev-sans-first:620.32 17:54:08 INFO - PROCESS | 28900 | Values: 3155.1 3185.8 3190.5 3207.2 3228.0 5622.0 5640.3 5665.5 5666.6 5707.2 5639.2 5692.1 5694.9 5697.6 5734.6 5118.7 5132.7 5143.3 5164.9 5205.8 5022.9 5222.0 5223.1 5224.0 5232.3 5015.7 5074.8 5090.0 5117.6 5155.9 5138.9 5165.2 5166.4 5222.2 5228.2 5086.5 5115.7 5186.8 5201.2 5229.1 5424.7 5439.4 5497.5 5508.5 5568.2 5921.9 5935.3 6009.1 6017.2 6026.1 6065.6 6071.5 6072.1 6083.2 6083.3 5428.4 5472.3 5557.5 5594.9 5609.4 6178.4 6193.3 6201.6 6209.6 6213.9 5924.7 5936.9 5937.3 5944.5 5951.3 5829.7 5889.6 5942.6 5967.8 5971.8 6016.6 6038.1 6041.2 6050.2 6077.3 6008.7 6061.6 6074.3 6077.1 6100.8 4523.8 4529.1 4536.0 4575.6 4667.1 4057.9 4063.7 4065.5 4099.1 4102.0 5638.0 5646.8 5667.9 5672.1 5676.5 5870.9 5931.6 5954.2 5954.3 5962.2 5668.0 5706.0 5713.0 5759.8 5792.6 5250.5 5260.3 5261.4 5267.0 5290.4 6020.3 6166.9 6186.3 6210.3 6230.9 5954.2 6029.5 6075.1 6082.1 6144.3 6291.6 6297.1 6303.2 6304.0 6308.8 6011.4 6018.3 6022.2 6027.8 6038.0 5823.4 5841.3 5991.7 6041.7 6043.8 5977.6 6015.2 6015.5 6017.2 6019.8 6007.1 6007.9 6019.7 6022.8 6025.7 5733.0 5763.9 5812.5 5865.0 5926.1 5949.9 5958.6 5963.7 5978.6 5996.6 5676.4 5807.4 5811.0 5814.3 5825.3 17:54:08 INFO - PROCESS | 28900 | 17:54:08 INFO - PROCESS | 28900 | [#1] ext.html Cycles:180 Average:62182.46 Median:21323.25 stddev:124870.73 (585.6%) stddev-sans-first:125135.42 17:54:08 INFO - PROCESS | 28900 | Values: 599.5 620.4 644.8 651.6 652.8 34014.8 38252.6 46062.5 46907.8 47105.0 47928.0 48281.3 48350.5 48380.0 48428.5 9307.3 9466.3 9476.3 9479.6 9482.6 8577.8 8798.8 10947.9 11176.7 11189.4 11379.9 11497.6 11498.9 11499.0 11499.7 11308.4 11374.4 11386.6 11390.3 11392.6 11075.6 11135.3 11145.6 11154.5 11162.6 45090.3 45200.1 45370.3 45398.3 45424.3 3771.9 3862.2 3863.5 4016.5 4147.9 34402.8 34532.3 34570.8 34946.3 35048.1 4445.1 4473.6 4502.6 4532.6 4588.3 354447.0 357976.0 359454.0 359815.0 359907.0 37966.2 61599.0 61619.7 61703.4 62004.4 38961.0 39494.8 39726.4 39748.8 39774.6 16487.3 16510.0 16519.9 16574.6 16584.3 11758.6 11761.0 14746.9 14916.5 14918.8 9245.4 9474.5 9485.7 9622.6 9728.5 3657.1 3693.4 3704.7 3719.0 3734.5 1035.2 1074.6 1078.8 1084.7 1167.5 34713.7 35035.6 35340.6 35382.6 35524.3 1184.0 1209.1 1240.2 1243.0 1277.7 17278.5 17962.8 18103.7 18320.6 18340.6 591182.0 593536.0 595899.0 598001.0 598143.0 62602.0 63176.0 63326.1 63359.0 63382.0 1295.4 1351.8 1399.7 1423.4 1443.9 33814.0 35312.6 35518.3 35804.5 36021.3 46109.8 46242.8 46258.8 46314.5 46351.0 422445.0 423757.0 423897.0 424770.0 427026.0 30275.2 31755.8 31846.0 33144.5 33249.0 51132.2 51201.7 51337.0 51855.5 52402.2 43204.8 44094.0 44519.4 44763.6 45600.5 44074.8 44635.6 45222.3 45691.8 46076.8 43462.6 44177.6 44513.6 44672.8 44790.6 35482.3 38530.7 38783.0 39446.6 39696.2 29264.6 29651.7 29762.9 29923.9 29927.9 17:54:08 INFO - PROCESS | 28900 | 17:54:08 INFO - PROCESS | 28900 | [#2] jquery.html Cycles:180 Average:31397.96 Median:22895.81 stddev:90616.31 (395.8%) stddev-sans-first:90840.61 17:54:08 INFO - PROCESS | 28900 | Values: 399.6 435.1 439.8 440.2 452.5 17314.8 19085.1 20832.3 21465.7 21723.1 19602.4 19616.8 20385.7 20857.3 20920.2 5754.3 5797.3 6013.4 6014.4 6016.1 5831.7 5842.3 5892.6 5892.8 5919.0 5655.6 5848.8 5850.6 5861.7 5864.6 5859.4 5903.4 5905.9 5906.3 5911.6 5312.5 5338.9 5346.3 5565.8 5624.4 22537.4 23254.2 23400.8 23965.4 24366.8 2449.8 2608.6 2618.5 2668.3 2925.5 10569.5 10673.6 10728.8 10832.2 10924.3 2034.3 2107.1 2123.9 2129.2 2152.2 76424.2 77665.0 77723.0 87323.6 90702.1 10531.2 11734.5 11753.1 11781.5 12113.4 15628.8 15709.8 16504.1 16559.5 17162.4 8760.1 8809.9 8882.2 8960.1 9035.5 8527.7 8585.5 8902.4 8959.2 9214.0 5131.0 5173.5 5197.8 5199.7 5279.9 2069.2 2070.9 2112.7 2136.7 2160.1 997.6 1044.0 1060.7 1067.5 1090.7 19440.8 20246.6 20382.8 20421.5 20856.6 988.4 999.5 1028.7 1057.5 1064.3 10901.5 10939.3 11869.8 11894.8 12366.6 541962.0 545867.0 552475.0 555667.0 555788.0 92728.0 93866.5 100720.5 106584.5 107097.5 1057.4 1067.1 1094.4 1095.5 1099.6 18469.4 18744.7 18850.9 19026.7 19398.8 41979.4 43579.6 44926.0 45301.5 46488.9 55939.0 56630.7 62951.0 63327.0 64708.7 6852.6 8286.7 8302.0 8814.3 9013.6 12689.4 13024.6 13045.4 13222.4 13240.4 11502.2 11527.5 11709.8 12093.3 12227.1 11139.7 11402.6 11505.8 11626.9 11769.7 11734.9 11791.7 11855.6 12072.8 12226.8 8381.0 8663.3 8716.8 8752.1 9074.6 11066.7 11832.9 11855.2 11994.4 12151.3 17:54:08 INFO - PROCESS | 28900 | 17:54:08 INFO - PROCESS | 28900 | [#3] mootools.html Cycles:180 Average:6269.61 Median:4698.84 stddev:3575.53 (76.1%) stddev-sans-first:3567.12 17:54:08 INFO - PROCESS | 28900 | Values: 1438.3 1561.4 1583.0 1694.2 1781.0 8259.1 8899.5 9202.8 9221.6 9522.0 9247.4 9353.6 9355.6 9359.5 9375.7 2524.2 2557.2 2557.2 2562.1 2564.7 2423.2 2529.0 2537.9 2542.3 2543.7 2486.6 2511.3 2571.1 2578.0 2578.4 2485.4 2500.9 2513.4 2540.2 2540.4 2504.2 2504.3 2512.8 2514.6 2541.8 9237.8 9361.2 9593.8 9711.8 9739.6 5730.4 5996.9 6001.4 6007.5 6009.6 3644.6 3810.2 3816.7 3854.9 3859.4 1288.1 1288.4 1290.7 1320.8 1328.9 13788.8 13830.4 13881.7 13928.1 13936.0 4946.4 5158.7 5189.1 5209.2 5273.3 10603.0 10603.0 10603.5 10630.6 10640.1 5737.5 5740.1 5744.7 5746.5 5749.1 4397.0 4557.2 4752.2 4768.8 5331.3 4208.5 4277.9 4362.6 4384.1 4393.4 1281.2 1281.2 1296.5 1316.4 1321.4 935.1 988.9 1047.7 1055.9 1056.0 6366.6 6492.5 6576.3 6630.7 6677.0 491.2 495.1 497.5 1057.9 1089.2 4441.3 4565.0 4570.7 4627.7 4645.5 11669.3 12039.5 12067.8 12068.5 12074.8 11297.0 11813.4 11819.2 12051.9 12166.8 8842.9 8997.1 9023.8 9074.0 9080.4 6202.3 6466.8 6530.8 6534.1 6549.2 10461.8 10755.7 10776.3 10867.7 10973.8 9906.4 10263.3 11006.2 11106.2 11129.8 8265.0 8378.3 8420.5 8469.0 8704.1 9319.9 9369.1 9384.6 9385.1 9401.4 8137.0 8364.2 8402.2 8453.6 8461.7 8095.6 8122.7 8136.2 8258.6 8365.2 7581.5 7661.7 7665.9 7750.7 7769.7 5533.9 5535.9 5598.9 5606.2 5695.1 5437.3 5453.0 5492.8 5535.8 5552.4 17:54:08 INFO - PROCESS | 28900 | 17:54:08 INFO - PROCESS | 28900 | [#4] prototype.html Cycles:180 Average:4782.88 Median:5346.19 stddev:1402.85 (26.2%) stddev-sans-first:1366.86 17:54:08 INFO - PROCESS | 28900 | Values: 355.4 358.5 361.7 362.8 369.1 5532.4 5545.5 5554.7 5568.7 5582.3 5498.6 5499.4 5519.6 5525.4 5542.5 4157.8 4270.6 4325.2 4334.6 4347.2 4328.4 4329.5 4332.0 4338.7 4345.6 4297.8 4300.4 4307.8 4316.4 4325.3 4144.7 4297.4 4305.1 4305.8 4318.7 3798.4 3805.0 3815.3 3821.7 3822.4 5361.9 5379.3 5382.2 5382.4 5409.5 4786.8 4870.5 4937.2 4957.6 4979.8 5720.3 5729.2 5730.5 5733.9 5740.4 4164.7 4188.8 4191.6 4220.6 4226.6 5890.5 5911.3 5952.2 5954.2 5989.7 4271.7 4275.3 4278.1 4282.2 4291.3 4323.8 4336.3 4345.9 4347.2 4367.4 4748.5 4926.9 4965.6 4971.2 4980.3 5802.9 5803.7 5805.9 5815.2 5836.9 1493.5 1512.9 1518.3 1521.1 1524.3 917.7 958.8 960.2 967.3 978.0 4895.9 4898.2 4906.1 4915.3 4919.5 5139.4 5153.7 5185.9 5207.5 5207.6 4628.0 4860.5 4875.8 4908.8 4916.4 2765.7 2767.6 2768.3 2769.5 2778.4 5304.9 5309.5 5313.7 5326.9 5330.5 5296.6 5363.7 5694.9 5799.9 6151.9 5994.3 6014.0 6132.3 6151.9 6162.9 5957.4 5975.0 5982.4 6002.0 6014.4 5673.7 5913.7 5925.0 5945.9 5970.9 6106.8 6115.8 6138.4 6202.2 6204.8 4116.6 4220.6 4263.8 4266.2 4304.2 5842.2 5907.6 5919.4 5919.4 5925.5 5759.9 5783.7 5784.1 5791.5 5806.8 5662.3 5786.1 5799.5 5800.7 5824.0 5770.3 5786.5 5792.9 5795.3 5821.2 5584.6 5826.3 5837.7 5839.2 5863.6 5649.2 5657.8 5669.6 5688.6 5718.1 17:54:08 INFO - PROCESS | 28900 | 17:54:08 INFO - PROCESS | 28900 | [#5] yui.html Cycles:180 Average:22588.31 Median:23712.70 stddev:33069.67 (139.5%) stddev-sans-first:33122.12 17:54:08 INFO - PROCESS | 28900 | Values: 841.5 859.1 859.5 893.0 914.6 13779.7 14292.7 14401.2 14404.9 14469.1 14830.3 14836.6 14911.1 15005.0 15007.3 841.1 870.3 871.4 871.7 871.8 728.4 747.1 832.0 860.4 867.6 909.9 914.6 916.8 916.8 919.2 912.6 912.7 914.2 914.7 915.5 553.6 566.1 644.5 659.0 664.7 14608.9 14649.3 14659.6 14676.3 14717.6 14037.4 14385.6 14551.5 14684.6 14855.1 13651.5 13671.8 13818.0 14016.0 14097.8 4571.8 4633.7 4639.5 4731.1 4738.6 87236.6 89094.6 89554.0 91857.0 93729.5 11817.5 12114.2 12240.9 12314.7 12480.8 21684.2 23469.6 23634.2 23673.5 23751.9 8860.9 8963.4 9001.7 9156.8 9239.1 4969.7 5169.8 5193.9 5228.9 5323.7 3820.9 3911.5 3943.6 3960.1 3976.4 680.9 688.2 689.3 692.8 698.8 748.6 799.9 805.3 806.9 820.5 10829.2 10864.4 11080.6 11169.7 11172.8 686.3 695.3 724.6 737.1 750.3 5079.5 5371.9 5391.1 5395.2 5447.6 121778.0 127422.4 128493.0 130117.3 135036.3 89766.6 112560.0 113322.0 116916.4 117925.0 72979.0 100059.5 100818.5 101129.5 101472.5 9649.6 10135.7 10167.9 10190.8 10191.2 49615.5 58428.4 58606.0 59823.4 61973.7 49814.0 65734.7 70227.3 70985.3 73154.3 14420.3 14552.3 14614.4 14652.7 14860.3 15563.0 15776.6 16564.7 16565.3 17834.0 13728.8 14077.2 14833.3 14955.3 15273.8 14222.6 14228.4 14369.6 14739.8 15197.9 14212.9 14251.6 14693.4 14783.1 15078.7 12264.3 13060.5 13295.5 13665.6 13717.4 12966.5 13049.8 13215.4 13262.2 13356.4 17:54:08 INFO - PROCESS | 28900 | -------- Summary: end -------- 17:54:08 INFO - PROCESS | 28900 | 17:54:09 INFO - TEST-INFO | 28900: exit 0 17:54:09 INFO - TEST-OK | dromaeo_css | took 1113643ms 17:54:09 INFO - TEST-START | kraken 17:54:09 INFO - operating with platform_type : linux_ 17:54:09 INFO - Initialising browser for kraken test... 17:54:09 INFO - TEST-INFO | started process 29221 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW4a6NX/profile http://localhost:34180/getInfo.html) 17:54:13 INFO - PROCESS | 29221 | __metrics Screen width/height:1600/1200 17:54:13 INFO - PROCESS | 29221 | colorDepth:24 17:54:13 INFO - PROCESS | 29221 | Browser inner width/height: 1024/697 17:54:13 INFO - PROCESS | 29221 | __metrics 17:54:13 INFO - PROCESS | 29221 | 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" 17:54:13 INFO - PROCESS | 29221 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:54:14 INFO - PROCESS | 29221 | console.error: PushService: 17:54:14 INFO - PROCESS | 29221 | stateChangeProcessEnqueue: Error transitioning state 17:54:14 INFO - PROCESS | 29221 | UnknownError 17:54:14 INFO - TEST-INFO | 29221: exit 0 17:54:14 INFO - Browser initialized. 17:54:14 INFO - Running cycle 1/1 for kraken test... 17:54:14 INFO - TEST-INFO | started process 29311 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW4a6NX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:54:26 INFO - PROCESS | 29311 | RSS: Main: 144072704 17:54:26 INFO - PROCESS | 29311 | 17:54:29 INFO - PROCESS | 29311 | Cycle 1(1): loaded http://localhost:34180/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34180/tests/kraken/driver.html?testName=audio-beat-detection) 17:54:30 INFO - PROCESS | 29311 | RSS: Main: 185159680 17:54:30 INFO - PROCESS | 29311 | 17:54:32 INFO - PROCESS | 29311 | Cycle 1(1): loaded http://localhost:34180/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34180/tests/kraken/driver.html?testName=audio-dft) 17:54:33 INFO - PROCESS | 29311 | RSS: Main: 174755840 17:54:33 INFO - PROCESS | 29311 | 17:54:35 INFO - PROCESS | 29311 | Cycle 1(1): loaded http://localhost:34180/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34180/tests/kraken/driver.html?testName=audio-fft) 17:54:36 INFO - PROCESS | 29311 | RSS: Main: 266043392 17:54:36 INFO - PROCESS | 29311 | 17:54:38 INFO - PROCESS | 29311 | Cycle 1(1): loaded http://localhost:34180/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34180/tests/kraken/driver.html?testName=audio-oscillator) 17:54:39 INFO - PROCESS | 29311 | RSS: Main: 172888064 17:54:39 INFO - PROCESS | 29311 | 17:54:41 INFO - PROCESS | 29311 | Cycle 1(1): loaded http://localhost:34180/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34180/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:54:41 INFO - PROCESS | 29311 | RSS: Main: 175063040 17:54:41 INFO - PROCESS | 29311 | 17:54:44 INFO - PROCESS | 29311 | Cycle 1(1): loaded http://localhost:34180/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34180/tests/kraken/driver.html?testName=imaging-darkroom) 17:54:45 INFO - PROCESS | 29311 | RSS: Main: 210452480 17:54:45 INFO - PROCESS | 29311 | 17:54:48 INFO - PROCESS | 29311 | Cycle 1(1): loaded http://localhost:34180/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34180/tests/kraken/driver.html?testName=imaging-desaturate) 17:54:49 INFO - PROCESS | 29311 | RSS: Main: 209428480 17:54:49 INFO - PROCESS | 29311 | 17:54:52 INFO - PROCESS | 29311 | Cycle 1(1): loaded http://localhost:34180/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34180/tests/kraken/driver.html?testName=json-parse-financial) 17:54:52 INFO - PROCESS | 29311 | RSS: Main: 209715200 17:54:52 INFO - PROCESS | 29311 | 17:54:54 INFO - PROCESS | 29311 | Cycle 1(1): loaded http://localhost:34180/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34180/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:54:54 INFO - PROCESS | 29311 | RSS: Main: 171126784 17:54:54 INFO - PROCESS | 29311 | 17:54:56 INFO - PROCESS | 29311 | Cycle 1(1): loaded http://localhost:34180/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34180/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:54:57 INFO - PROCESS | 29311 | RSS: Main: 178733056 17:54:57 INFO - PROCESS | 29311 | 17:54:59 INFO - PROCESS | 29311 | Cycle 1(1): loaded http://localhost:34180/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34180/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:54:59 INFO - PROCESS | 29311 | RSS: Main: 188305408 17:54:59 INFO - PROCESS | 29311 | 17:55:02 INFO - PROCESS | 29311 | Cycle 1(1): loaded http://localhost:34180/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34180/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:55:02 INFO - PROCESS | 29311 | RSS: Main: 197091328 17:55:02 INFO - PROCESS | 29311 | 17:55:05 INFO - PROCESS | 29311 | Cycle 1(1): loaded http://localhost:34180/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34180/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:55:06 INFO - PROCESS | 29311 | RSS: Main: 193339392 17:55:06 INFO - PROCESS | 29311 | 17:55:07 INFO - PROCESS | 29311 | Cycle 1(1): loaded http://localhost:34180/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34180/tests/kraken/driver.html?testName=ai-astar) 17:55:08 INFO - PROCESS | 29311 | RSS: Main: 245194752 17:55:08 INFO - PROCESS | 29311 | 17:55:08 INFO - PROCESS | 29311 | __start_tp_report 17:55:08 INFO - PROCESS | 29311 | _x_x_mozilla_page_load 17:55:08 INFO - PROCESS | 29311 | _x_x_mozilla_page_load_details 17:55:08 INFO - PROCESS | 29311 | |i|pagename|runs| 17:55:08 INFO - PROCESS | 29311 | |0;ai-astar;108;112;110;109;110;110;111;110;109;111 17:55:08 INFO - PROCESS | 29311 | |1;audio-beat-detection;144;115;114;157;123;120;117;120;150;118 17:55:08 INFO - PROCESS | 29311 | |2;audio-dft;161;161;160;162;159;159;163;161;160;159 17:55:08 INFO - PROCESS | 29311 | |3;audio-fft;75;75;76;106;76;77;77;75;100;76 17:55:08 INFO - PROCESS | 29311 | |4;audio-oscillator;81;81;110;81;82;82;104;81;81;109 17:55:08 INFO - PROCESS | 29311 | |5;imaging-gaussian-blur;117;117;118;117;117;117;116;116;117;117 17:55:08 INFO - PROCESS | 29311 | |6;imaging-darkroom;146;147;146;146;147;146;145;147;146;146 17:55:08 INFO - PROCESS | 29311 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 17:55:08 INFO - PROCESS | 29311 | |8;json-parse-financial;50;48;49;48;48;48;50;48;54;48 17:55:08 INFO - PROCESS | 29311 | |9;json-stringify-tinderbox;58;59;60;59;59;60;63;59;59;59 17:55:08 INFO - PROCESS | 29311 | |10;stanford-crypto-aes;75;74;74;73;74;74;74;73;74;74 17:55:08 INFO - PROCESS | 29311 | |11;stanford-crypto-ccm;123;124;122;121;121;120;119;118;152;121 17:55:08 INFO - PROCESS | 29311 | |12;stanford-crypto-pbkdf2;155;154;153;152;154;158;160;154;158;154 17:55:08 INFO - PROCESS | 29311 | |13;stanford-crypto-sha256-iterative;62;61;62;63;61;62;63;62;65;61 17:55:08 INFO - PROCESS | 29311 | __end_tp_report 17:55:08 INFO - PROCESS | 29311 | __start_cc_report 17:55:08 INFO - PROCESS | 29311 | _x_x_mozilla_cycle_collect,1573 17:55:08 INFO - PROCESS | 29311 | __end_cc_report 17:55:08 INFO - PROCESS | 29311 | __startTimestamp1477356908020__endTimestamp 17:55:08 INFO - PROCESS | 29311 | 17:55:08 INFO - PROCESS | 29311 | ------- Summary: start ------- 17:55:08 INFO - PROCESS | 29311 | Number of tests: 14 17:55:08 INFO - PROCESS | 29311 | 17:55:08 INFO - PROCESS | 29311 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.00 stddev:1.15 (1.0%) stddev-sans-first:0.97 17:55:08 INFO - PROCESS | 29311 | Values: 108.0 112.0 110.0 109.0 110.0 110.0 111.0 110.0 109.0 111.0 17:55:08 INFO - PROCESS | 29311 | 17:55:08 INFO - PROCESS | 29311 | [#1] audio-beat-detection Cycles:10 Average:127.80 Median:121.50 stddev:16.05 (13.2%) stddev-sans-first:15.92 17:55:08 INFO - PROCESS | 29311 | Values: 144.0 115.0 114.0 157.0 123.0 120.0 117.0 120.0 150.0 118.0 17:55:08 INFO - PROCESS | 29311 | 17:55:08 INFO - PROCESS | 29311 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.35 (0.8%) stddev-sans-first:1.42 17:55:08 INFO - PROCESS | 29311 | Values: 161.0 161.0 160.0 162.0 159.0 159.0 163.0 161.0 160.0 159.0 17:55:08 INFO - PROCESS | 29311 | 17:55:08 INFO - PROCESS | 29311 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.00 stddev:11.55 (15.2%) stddev-sans-first:12.02 17:55:08 INFO - PROCESS | 29311 | Values: 75.0 75.0 76.0 106.0 76.0 77.0 77.0 75.0 100.0 76.0 17:55:08 INFO - PROCESS | 29311 | 17:55:08 INFO - PROCESS | 29311 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:81.00 stddev:12.84 (15.9%) stddev-sans-first:13.27 17:55:08 INFO - PROCESS | 29311 | Values: 81.0 81.0 110.0 81.0 82.0 82.0 104.0 81.0 81.0 109.0 17:55:08 INFO - PROCESS | 29311 | 17:55:08 INFO - PROCESS | 29311 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 17:55:08 INFO - PROCESS | 29311 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 17:55:08 INFO - PROCESS | 29311 | 17:55:08 INFO - PROCESS | 29311 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 17:55:08 INFO - PROCESS | 29311 | Values: 146.0 147.0 146.0 146.0 147.0 146.0 145.0 147.0 146.0 146.0 17:55:08 INFO - PROCESS | 29311 | 17:55:08 INFO - PROCESS | 29311 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 17:55:08 INFO - PROCESS | 29311 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 17:55:08 INFO - PROCESS | 29311 | 17:55:08 INFO - PROCESS | 29311 | [#8] json-parse-financial Cycles:10 Average:49.10 Median:48.50 stddev:1.91 (3.9%) stddev-sans-first:2.00 17:55:08 INFO - PROCESS | 29311 | Values: 50.0 48.0 49.0 48.0 48.0 48.0 50.0 48.0 54.0 48.0 17:55:08 INFO - PROCESS | 29311 | 17:55:08 INFO - PROCESS | 29311 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:59.00 stddev:1.35 (2.3%) stddev-sans-first:1.32 17:55:08 INFO - PROCESS | 29311 | Values: 58.0 59.0 60.0 59.0 59.0 60.0 63.0 59.0 59.0 59.0 17:55:08 INFO - PROCESS | 29311 | 17:55:08 INFO - PROCESS | 29311 | [#10] stanford-crypto-aes Cycles:10 Average:73.90 Median:74.00 stddev:0.57 (0.8%) stddev-sans-first:0.44 17:55:08 INFO - PROCESS | 29311 | Values: 75.0 74.0 74.0 73.0 74.0 74.0 74.0 73.0 74.0 74.0 17:55:08 INFO - PROCESS | 29311 | 17:55:08 INFO - PROCESS | 29311 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:121.50 stddev:9.96 (8.2%) stddev-sans-first:10.56 17:55:08 INFO - PROCESS | 29311 | Values: 123.0 124.0 122.0 121.0 121.0 120.0 119.0 118.0 152.0 121.0 17:55:08 INFO - PROCESS | 29311 | 17:55:08 INFO - PROCESS | 29311 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:154.50 stddev:2.57 (1.7%) stddev-sans-first:2.73 17:55:08 INFO - PROCESS | 29311 | Values: 155.0 154.0 153.0 152.0 154.0 158.0 160.0 154.0 158.0 154.0 17:55:08 INFO - PROCESS | 29311 | 17:55:08 INFO - PROCESS | 29311 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.00 stddev:1.23 (2.0%) stddev-sans-first:1.30 17:55:08 INFO - PROCESS | 29311 | Values: 62.0 61.0 62.0 63.0 61.0 62.0 63.0 62.0 65.0 61.0 17:55:08 INFO - PROCESS | 29311 | -------- Summary: end -------- 17:55:08 INFO - PROCESS | 29311 | 17:55:08 INFO - TEST-INFO | 29311: exit 0 17:55:09 INFO - TEST-OK | kraken | took 59879ms 17:55:09 INFO - SUITE-END | took 1173s 17:55:09 INFO - Completed test suite (00:19:33) 17:55:09 INFO - javascript benchmark 17:55:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3155.1481100102974, 3185.8088514689107, 3190.5373720810485, 3207.16613680443, 3227.951580726288, 5622.044252477079, 5640.323161220655, 5665.5467562594995, 5666.631668941516, 5707.229524014257, 5639.210510528529, 5692.089265717486, 5694.943050569493, 5697.572682048853, 5734.627249228808, 5118.667286626367, 5132.717700526469, 5143.27994080829, 5164.92252616211, 5205.843824685247, 5022.874428139289, 5222.033923724123, 5223.085959957011, 5224.0, 5232.293640358541, 5015.7492125393765, 5074.822381216658, 5090.0328937501945, 5117.616178786588, 5155.871103222431, 5138.948610513903, 5165.225216217578, 5166.43169251382, 5222.216667499867, 5228.215767634847, 5086.491350864884, 5115.693058416507, 5186.818461353834, 5201.245819356172, 5229.137192363255, 5424.674519528801, 5439.428859969726, 5497.45025497451, 5508.531774799147, 5568.248286481314, 5921.851953701149, 5935.317438494585, 6009.06859436788, 6017.187679663277, 6026.126211699323, 6065.605735627214, 6071.483923866476, 6072.089186621998, 6083.209182806251, 6083.270007599072, 5428.4300148484235, 5472.26124473195, 5557.472040156219, 5594.916076258859, 5609.439056094439, 6178.382161783786, 6193.256809182837, 6201.627902325875, 6209.565330426917, 6213.937860621336, 5924.674142922181, 5936.940630593639, 5937.287525496968, 5944.524438044946, 5951.315598706117, 5829.650220986669, 5889.587728858939, 5942.613730107616, 5967.8209653710455, 5971.790987315423, 6016.608920420159, 6038.064100064497, 6041.184440100618, 6050.183225264533, 6077.301110372276, 6008.729607167688, 6061.636301821904, 6074.271087469532, 6077.058056001327, 6100.786472473531, 4523.751193684313, 4529.116822219701, 4536.02475467776, 4575.633949284049, 4667.113248482778, 4057.9391309129796, 4063.654589359878, 4065.5324637667045, 4099.098198396348, 4101.97949010259, 5638.04153293941, 5646.830595082154, 5667.886642267132, 5672.064109421982, 5676.489115979582, 5870.941290587125, 5931.6441013539325, 5954.225950626391, 5954.255718035246, 5962.2249107615735, 5668.0, 5706.001449746361, 5713.028785106542, 5759.769609215668, 5792.623479473821, 5250.501202385767, 5260.263563101169, 5261.394939581997, 5267.0, 5290.365156181283, 6020.277566692025, 6166.9383306167265, 6186.288576813724, 6210.285817131088, 6230.906536401958, 5954.19618351517, 6029.51763858899, 6075.149479072845, 6082.057281121433, 6144.341027922525, 6291.559590828598, 6297.118403423433, 6303.180586523723, 6304.022876454157, 6308.842278943063, 6011.398860113954, 6018.2778066630535, 6022.1870047543025, 6027.819165425044, 6038.0, 5823.35943046273, 5841.299044114733, 5991.700414979321, 6041.69791510414, 6043.848903777441, 5977.581569290108, 6015.187949626745, 6015.518758499222, 6017.247844019497, 6019.789307374221, 6007.068904319837, 6007.87984240304, 6019.668918209365, 6022.759089636541, 6025.728842202024, 5733.0, 5763.855903602276, 5812.476877081083, 5864.970675146597, 5926.081457373942, 5949.91075133882, 5958.6424814511265, 5963.73163207648, 5978.581499295007, 5996.640201587918, 5676.403977582295, 5807.361190269152, 5811.041178205718, 5814.273215848019, 5825.300963884191], "value": 5557.773064977889, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.5173885022558, 620.392015824492, 644.7711062572789, 651.6188030002447, 652.7747926965195, 34014.82992585037, 38252.61747382525, 46062.53937460625, 46907.765461172734, 47105.0, 47928.0, 48281.27578086332, 48350.51649483504, 48380.0, 48428.51571484284, 9307.255419566436, 9466.290028247875, 9476.336656434052, 9479.573419196153, 9482.573284202228, 8577.785555361104, 8798.780030499225, 10947.890521094767, 11176.720581985433, 11189.384583847885, 11379.886201137966, 11497.597584084559, 11498.885011149865, 11499.0, 11499.712507187303, 11308.37803920784, 11374.37440940748, 11386.601468948547, 11390.316581005125, 11392.601258955896, 11075.612353567667, 11135.33188008722, 11145.609903653332, 11154.498047587878, 11162.553497860075, 45090.32364514535, 45200.09599807985, 45370.31944520835, 45398.31902521432, 45424.3186352205, 3771.9057023574355, 3862.1889403225355, 3863.497745293094, 4016.5180178378782, 4147.875563733093, 34402.82798585991, 34532.309353813034, 34570.827145864365, 34946.30107397863, 35048.12379690503, 4445.1331990261915, 4473.552644735533, 4502.6172775314135, 4532.637389008872, 4588.26587745959, 354447.0, 357976.0, 359454.0, 359815.0, 359907.0, 37966.24067518634, 61599.0, 61619.691901541104, 61703.38296617066, 62004.37995620076, 38961.0, 39494.80252598719, 39726.40410393846, 39748.80125599354, 39774.60225397709, 16487.258073386725, 16510.0, 16519.91740041292, 16574.585635359213, 16584.336626534805, 11758.5884494044, 11761.0, 14746.852531474548, 14916.477923272634, 14918.776218356734, 9245.3528253023, 9474.526273686288, 9485.715428537154, 9622.566984485715, 9728.513574321256, 3657.122290650225, 3693.353663108945, 3704.7406681532034, 3718.981405092957, 3734.4605668145377, 1035.2080658296409, 1074.6131392698621, 1078.8456351703758, 1084.6637542361734, 1167.5329868052677, 34713.65286347104, 35035.64964350375, 35340.64659353425, 35382.64617353845, 35524.28951421009, 1183.9704007399712, 1209.1233855454725, 1240.237254088747, 1242.9813552796534, 1277.7189018415934, 17278.459018021247, 17962.751388216788, 18103.72844407335, 18320.633587328444, 18340.633187336178, 591182.0, 593536.0, 595899.0, 598001.0, 598143.0, 62602.0, 63176.0, 63326.0501092484, 63359.0, 63382.0, 1295.436485128972, 1351.8310211223597, 1399.657084014423, 1423.4021710881455, 1443.949461768833, 33814.0, 35312.646873531965, 35518.289634207686, 35804.462933056544, 36021.27957440889, 46109.769451152526, 46242.76878615585, 46258.768706156254, 46314.53685463102, 46351.0, 422445.0, 423757.0, 423897.0, 424770.0, 427026.0, 30275.24311892132, 31755.841220793747, 31846.0, 33144.50283245801, 33249.0, 51132.233016505525, 51201.74399127981, 51337.0, 51855.481445186575, 52402.21396679129, 43204.78397607992, 44094.0, 44519.44181953616, 44763.55236447724, 45600.54399455963, 44074.77962610166, 44635.553644463136, 45222.32166517439, 45691.77154114208, 46076.7696161517, 43462.56537434585, 44177.55822441863, 44513.55486445094, 44672.776636116614, 44790.55209447864, 35482.29035419329, 38530.74134304091, 38783.0, 39446.60553394429, 39696.206075877744, 29264.56103158497, 29651.703482964895, 29762.851185743933, 29923.850380747957, 29927.850360748056], "value": 20495.829609015636, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.6003996003996, 435.12105546795476, 439.7708405008003, 440.15270604087135, 452.4864279043287, 17314.82685173148, 19085.14116864741, 20832.270870519536, 21465.67801482975, 21723.13107475699, 19602.41192764216, 19616.803831961675, 20385.694214586794, 20857.26999555016, 20920.163193472243, 5754.309482862062, 5797.304323481178, 6013.368596297391, 6014.368491308415, 6016.0975853622085, 5831.708414579275, 5842.32813226478, 5892.558058145635, 5892.823215303548, 5918.99377105893, 5655.57583181261, 5848.766049358021, 5850.619709718854, 5861.736221870005, 5864.618799778023, 5859.355470898197, 5903.35063143054, 5905.9409405906035, 5906.26171728534, 5911.586188966752, 5312.468753124656, 5338.866528336784, 5346.331708536433, 5565.777368905239, 5624.3813180550105, 22537.43656408603, 23254.186103486467, 23400.765992340028, 23965.40086497834, 24366.756332436627, 2449.7917676997477, 2608.5565453872887, 2618.450125473653, 2668.2795645175693, 2925.502664547032, 10569.524371403306, 10673.573057077707, 10728.839067413996, 10832.241743077988, 10924.2899211551, 2034.3185033013958, 2107.115011695076, 2123.904424300895, 2129.233475948657, 2152.2251989283845, 76424.23575764227, 77665.0, 77723.0, 87323.56338218332, 90702.09297907069, 10531.157507399543, 11734.530618775325, 11753.118516111155, 11781.528738850522, 12113.39433028345, 15628.843711562966, 15709.764353534707, 16504.092274924995, 16559.503214903572, 17162.39931602388, 8760.12398760119, 8809.911900880908, 8882.245009174163, 8960.05919378469, 9035.45787252767, 8527.678209877478, 8585.484870907765, 8902.376833621714, 8959.23846473044, 9213.95393023044, 5130.999455106218, 5173.456787037307, 5197.8440646780655, 5199.66202196856, 5279.947200528022, 2069.2343832781967, 2070.9171633134806, 2112.704221409004, 2136.6688163334707, 2160.1143531152466, 997.6109317366233, 1044.0186224948525, 1060.7454210989306, 1067.5356220044305, 1090.6782499162766, 19440.805591944183, 20246.59506809885, 20382.796172038088, 20421.489462763253, 20856.58286834255, 988.3575675810637, 999.4902599674218, 1028.711960651019, 1057.471264367816, 1064.2709743825349, 10901.52829368041, 10939.28894621847, 11869.762604747857, 11894.762104757856, 12366.567170149001, 541962.0, 545867.0, 552475.0, 555667.0, 555788.0, 92728.0, 93866.53066734623, 100720.49639751755, 106584.46707766411, 107097.46451267693, 1057.381431862369, 1067.0609863320228, 1094.4363652718855, 1095.5070218401752, 1099.6151347028635, 18469.353572624892, 18744.718829217847, 18850.905745471733, 19026.714599280745, 19398.8060119397, 41979.37030944599, 43579.56420435755, 44926.0, 45301.546984529734, 46488.90799913945, 55939.0, 56630.716846415504, 62951.0, 63327.0, 64708.67645661742, 6852.5545839522265, 8286.70996515119, 8302.045264794626, 8814.250788682777, 9013.639454422011, 12689.4289756963, 13024.609261722164, 13045.412956416794, 13222.4049917752, 13240.40418181165, 11502.194846360675, 11527.538898444303, 11709.824352634547, 12093.33486658207, 12227.082968777555, 11139.665810025712, 11402.600908968147, 11505.769884602429, 11626.941865290619, 11769.705757356134, 11734.94132529332, 11791.705207369541, 11855.644330670093, 12072.75854482923, 12226.755464890475, 8381.0, 8663.263622591898, 8716.825663486821, 8752.081031491602, 9074.637014519609, 11066.667999960015, 11832.940835295769, 11855.162449820291, 11994.400279986141, 12151.331676757864], "value": 9671.94621583644, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1438.3383643523978, 1561.4300780215221, 1582.9920850395747, 1694.161390111895, 1781.0, 8259.132791056934, 8899.510526921016, 9202.769930751727, 9221.58502867371, 9522.000189980055, 9247.445153290808, 9353.579088940996, 9355.578998945046, 9359.48522831244, 9375.6718514852, 2524.192258477288, 2557.1689201009654, 2557.181701855407, 2562.090457887451, 2564.6922369315707, 2423.1882319423016, 2529.0389651932333, 2537.949241015179, 2542.275451496324, 2543.669322988009, 2486.627005949104, 2511.309389917769, 2571.112966026718, 2577.9613305800335, 2578.3940773918116, 2485.3662316109458, 2500.8874600643016, 2513.42191296002, 2540.187140115164, 2540.352210186409, 2504.211173480348, 2504.2862784106624, 2512.836665616729, 2514.622806579028, 2541.783948364391, 9237.815243695088, 9361.204297634642, 9593.808123837554, 9711.805763884682, 9739.56171972263, 5730.36965933747, 5996.880062398727, 6001.369856165127, 6007.459328660441, 6009.57932944694, 3644.5808731995894, 3810.161764411825, 3816.656500914931, 3854.9036274093373, 3859.3824988002066, 1288.0532808385829, 1288.375138058041, 1290.6708789258773, 1320.7886738121854, 1328.8604696506825, 13788.793168102486, 13830.37763300654, 13881.652958676013, 13928.094673846168, 13936.0, 4946.431160416598, 5158.664686795346, 5189.11784996544, 5209.166533354645, 5273.2617433559335, 10603.0, 10603.0, 10603.522841472151, 10630.574777008833, 10640.148788096934, 5737.512311453574, 5740.1102829061565, 5744.712764361765, 5746.5402767779315, 5749.108888122348, 4397.0, 4557.156925968707, 4752.2158843790385, 4768.7615619218905, 5331.280277162534, 4208.494980602286, 4277.893052673708, 4362.629176519968, 4384.101259241847, 4393.362962370438, 1281.1672412931669, 1281.2440660010639, 1296.5138073222543, 1316.3681432912256, 1321.359140816703, 935.0784138595117, 988.8763904511936, 1047.6699839550517, 1055.9155267578576, 1055.9683209503728, 6366.586171898812, 6492.5455218134275, 6576.309487503743, 6630.734770609218, 6677.031830384567, 491.2017970797454, 495.0742112250043, 497.54971750565795, 1057.8783439904355, 1089.199438412766, 4441.311596702516, 4564.950061485811, 4570.7257564546235, 4627.67606267558, 4645.465771436328, 11669.299842009506, 12039.458224379923, 12067.75864482723, 12068.517259309529, 12074.758504829853, 11297.0, 11813.40932953366, 11819.231749936227, 12051.939740301417, 12166.756664866652, 8842.867356989651, 8997.145271199226, 9023.819523609622, 9074.0, 9080.364374493722, 6202.317745047951, 6466.773662921775, 6530.771423000172, 6534.052562378333, 6549.24683661385, 10461.790764184825, 10755.677329680122, 10776.29954052984, 10867.728306792393, 10973.835392469278, 9906.356086854332, 10263.281570290306, 11006.174536909924, 11106.16703747206, 11129.83305250438, 8265.0, 8378.287845533197, 8420.452670576393, 8469.0, 8704.129587041245, 9319.906800931903, 9369.109934556207, 9384.624615015324, 9385.108414700593, 9401.435913845191, 8137.0, 8364.247217750431, 8402.159784021549, 8453.619587118472, 8461.746147615582, 8095.595220239083, 8122.675092996214, 8136.1863813618165, 8258.628361723617, 8365.205305495969, 7581.469297149147, 7661.655225514976, 7665.885011724717, 7750.689972401041, 7769.650365733442, 5533.889322213453, 5535.916961245504, 5598.944010559842, 5606.18710286998, 5695.060315047971, 5437.32033495813, 5452.991196628636, 5492.835214943399, 5535.750891209825, 5552.416996215339], "value": 4977.601537995791, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.417115929875, 358.4784139077642, 361.7323180846175, 362.7533277371387, 369.0533780852116, 5532.419095994923, 5545.504522964667, 5554.72226388681, 5568.7215639217975, 5582.302212223472, 5498.642588231762, 5499.395066542677, 5519.641223320481, 5525.392206857253, 5542.528885044766, 4157.833686652538, 4270.636995855356, 4325.243082460573, 4334.5882141196535, 4347.152615037156, 4328.350747387885, 4329.523752387235, 4331.956680433203, 4338.652907767387, 4345.630621397185, 4297.806598703066, 4300.440942677463, 4307.806148723299, 4316.352547117926, 4325.264705000158, 4144.6529877789835, 4297.39836422901, 4305.138972205556, 4305.827766889321, 4318.69769116162, 3798.3542797724454, 3804.9809750951345, 3815.2560250751117, 3821.675157611606, 3822.445745366906, 5361.919571206435, 5379.273798037254, 5382.192671099367, 5382.434844341327, 5409.486098820606, 4786.7845946932475, 4870.464248932614, 4937.1732458990045, 4957.5786058185095, 4979.825706100305, 5720.256366672347, 5729.169270455761, 5730.512906402961, 5733.856653583652, 5740.397258287861, 4164.729292596002, 4188.769617671027, 4191.580841915784, 4220.556841531657, 4226.619604235603, 5890.499307558863, 5911.349751527328, 5952.1964534787685, 5954.166416701665, 5989.670568118751, 4271.654428854963, 4275.294576394922, 4278.08021275421, 4282.207791558571, 4291.334843099325, 4323.783810809447, 4336.349547567827, 4345.9348109778375, 4347.239233134252, 4367.388565600819, 4748.50703380721, 4926.9014619707405, 4965.577925876269, 4971.1549036663855, 4980.252962055721, 5802.854928626818, 5803.6807975560905, 5805.912911306334, 5815.214945982323, 5836.8540786479825, 1493.4772829509584, 1512.9319180636899, 1518.3395223077996, 1521.1329542161084, 1524.3445318512925, 917.7430319510547, 958.8445922663174, 960.1790469148917, 967.2842096848282, 977.9853501786201, 4895.877603059952, 4898.240772680169, 4906.067847109038, 4915.311856340115, 4919.450373132452, 5139.408967968731, 5153.716545589954, 5185.948140518622, 5207.54188827129, 5207.557357624644, 4628.004978929546, 4860.465348811628, 4875.780589873464, 4908.809273971947, 4916.360873086476, 2765.6681198256338, 2767.6125342452074, 2768.29408500831, 2769.487644785721, 2778.388754474053, 5304.867378315573, 5309.522143007148, 5313.734313284398, 5326.893462130735, 5330.466953304638, 5296.576273898079, 5363.731813409314, 5694.9430505695245, 5799.942000580025, 6151.876962460726, 5994.250718660168, 6013.9699301503215, 6132.264128304543, 6151.9384806151365, 6162.938370616326, 5957.434043765836, 5974.970125149346, 5982.4316689914385, 6001.99900049975, 6014.368491308524, 5673.687947162945, 5913.70431478433, 5924.9703751480965, 5945.927039977629, 5970.880582388241, 6106.847328816815, 6115.755369785336, 6138.416850399205, 6202.193714817045, 6204.844878878064, 4116.608922152391, 4220.556841531595, 4263.808128634157, 4266.232078225949, 4304.246756817607, 5842.152887831326, 5907.586468947133, 5919.378465261258, 5919.408059194218, 5925.496332811759, 5759.9136012959, 5783.710814459344, 5784.050134431386, 5791.507721843691, 5806.767729290781, 5662.320521537442, 5786.07422812348, 5799.4780469757925, 5800.738966746591, 5823.970880145572, 5770.297762160257, 5786.537077033743, 5792.913106303325, 5795.304563452412, 5821.185034095315, 5584.553235741049, 5826.300843898759, 5837.708114594168, 5839.211706419749, 5863.648181109147, 5649.180868774087, 5657.773689052557, 5669.603127781016, 5688.5733569981585, 5718.142278658234], "value": 4342.214439463762, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [841.4824882697139, 859.1151114352217, 859.5444414460338, 892.977675558111, 914.5655813488598, 13779.655508612277, 14292.71414571708, 14401.20793356365, 14404.927975360108, 14469.059511131769, 14830.332635031422, 14836.554903352917, 14911.10533367996, 15005.0, 15007.324670389831, 841.0874201491389, 870.316801310971, 871.3551971541045, 871.6949067826242, 871.7689812199773, 728.3663213004667, 747.114669117098, 832.0389949608182, 860.3934226370425, 867.6009035843488, 909.8680691299791, 914.6387177065055, 916.7708072981754, 916.839553078212, 919.2186641354829, 912.5574096563162, 912.7307444303947, 914.1589737441536, 914.7484441778531, 915.4644532948166, 553.6346011632303, 566.1055532259021, 644.5423749138117, 659.0410952064782, 664.6776313487954, 14608.926955365261, 14649.267536623127, 14659.560213193621, 14676.339564719614, 14717.55847324582, 14037.368318425695, 14385.568432947028, 14551.490697825526, 14684.559463216014, 14855.108693478425, 13651.453941842314, 13671.794923076162, 13818.0, 14016.0, 14097.78853317201, 4571.839985600488, 4633.652476064275, 4639.512851150648, 4731.053789242131, 4738.64460165489, 87236.56381718114, 89094.55452722759, 89554.0, 91857.0, 93729.53135234349, 11817.527298908119, 12114.21257618252, 12240.877591223974, 12314.692132696755, 12480.75038499243, 21684.24105156312, 23469.647955280685, 23634.17280395178, 23673.526529469313, 23751.881240594033, 8860.911390886009, 8963.417377870548, 9001.684941027033, 9156.816863662823, 9239.076092390842, 4969.652124351333, 5169.81905633301, 5193.922091168635, 5228.9477105229225, 5323.653962492425, 3820.9044773880873, 3911.471951286597, 3943.5662077171487, 3960.148568057881, 3976.4035394691027, 680.8706345794283, 688.2257460357098, 689.2797027106685, 692.8164036530324, 698.800841760096, 748.6144635512716, 799.9000124984377, 805.3476683886071, 806.9314108300861, 820.5404973215019, 10829.24195306321, 10864.402457864735, 11080.61217857371, 11169.664910052712, 11172.776544469227, 686.3308274432488, 695.2908033805592, 724.6340597997977, 737.1154614462666, 750.339701063061, 5079.517445842639, 5371.865703357369, 5391.110466772939, 5395.21769343443, 5447.618666693294, 121778.0, 127422.36288818682, 128493.0, 130117.34941325423, 135036.3248183753, 89766.55116724374, 112560.0, 113322.0, 116916.41541792237, 117925.0, 72979.0, 100059.49970250102, 100818.49590751853, 101129.49435252776, 101472.49263753781, 9649.582503581103, 10135.7466063349, 10167.898321016992, 10190.847137292798, 10191.184705223712, 49615.503844962535, 58428.415715844, 58606.0, 59823.40176598352, 61973.690131549054, 49814.00371992467, 65734.67132664306, 70227.31472925497, 70985.29014709787, 73154.26845731474, 14420.278986050866, 14552.272386380428, 14614.415423382945, 14652.706945861237, 14860.256987150384, 15563.0, 15776.60558486047, 16564.668706626042, 16565.337386504885, 17834.0, 13728.794068088788, 14077.225752583707, 14833.258337083318, 14955.32701028478, 15273.770893436385, 14222.644433889236, 14228.430862765374, 14369.64075898111, 14739.778903316244, 15197.93614446978, 14212.92893535567, 14251.643708906946, 14693.412263509339, 14783.113013219241, 15078.698426031637, 12264.325462099314, 13060.542880999119, 13295.534656286984, 13665.590032298649, 13717.382717777924, 12966.546170883974, 13049.804252936403, 13215.405306761026, 13262.204267743966, 13356.422673864812], "value": 8166.177896716111, "unit": "score"}], "name": "dromaeo_css", "value": 7611.649668954113, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 112.0, 110.0, 109.0, 110.0, 110.0, 111.0, 110.0, 109.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 115.0, 114.0, 157.0, 123.0, 120.0, 117.0, 120.0, 150.0, 118.0], "value": 127.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 162.0, 159.0, 159.0, 163.0, 161.0, 160.0, 159.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 106.0, 76.0, 77.0, 77.0, 75.0, 100.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 110.0, 81.0, 82.0, 82.0, 104.0, 81.0, 81.0, 109.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 145.0, 147.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 48.0, 49.0, 48.0, 48.0, 48.0, 50.0, 48.0, 54.0, 48.0], "value": 49.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 60.0, 59.0, 59.0, 60.0, 63.0, 59.0, 59.0, 59.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 73.0, 74.0, 74.0, 74.0, 73.0, 74.0, 74.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 124.0, 122.0, 121.0, 121.0, 120.0, 119.0, 118.0, 152.0, 121.0], "value": 124.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 154.0, 153.0, 152.0, 154.0, 158.0, 160.0, 154.0, 158.0, 154.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 63.0, 61.0, 62.0, 63.0, 62.0, 65.0, 61.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1451.0000000000002, "alertThreshold": 2.0}]} 17:55:09 INFO - Return code: 0 17:55:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:55:09 INFO - # TBPL SUCCESS # 17:55:09 INFO - Running post-action listener: _resource_record_post_action 17:55:09 INFO - [mozharness: 2016-10-25 00:55:09.358056Z] Finished run-tests step (success) 17:55:09 INFO - Running post-run listener: _resource_record_post_run 17:55:09 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 357568512; Read time: 12; Write time: 233680 17:55:09 INFO - TinderboxPrint: CPU usage
13.0% 17:55:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:55:09 INFO - TinderboxPrint: I/O write bytes / time
357,568,512 / 233,680 17:55:09 INFO - TinderboxPrint: CPU idle
8,267.1 (87.0%) 17:55:09 INFO - TinderboxPrint: CPU user
1,186.6 (12.5%) 17:55:09 INFO - TinderboxPrint: Swap in / out
0 / 0 17:55:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107307008; Read time: 0; Write time: 85820 17:55:09 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 249016320; Read time: 0; Write time: 147816 17:55:09 INFO - Running post-run listener: _upload_blobber_files 17:55:09 INFO - Blob upload gear active. 17:55:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:55:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:55:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:55:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:55:10 INFO - (blobuploader) - INFO - Open directory for files ... 17:55:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:55:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:55:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:14 INFO - (blobuploader) - INFO - Done attempting. 17:55:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:55:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:55:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:14 INFO - (blobuploader) - INFO - Done attempting. 17:55:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:55:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:55:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:15 INFO - (blobuploader) - INFO - Done attempting. 17:55:15 INFO - (blobuploader) - INFO - Iteration through files over. 17:55:15 INFO - Return code: 0 17:55:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:55:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:55:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c872da15aa2dffdd46f2e4e45d6116963be05fe30a61174c875bf4a6df7bb311fb39ebde6d6ec502c72fedfcee11fa9ff74d9eb13f4d566f5968a41ef464812b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa98b2a24779185efa36acf4f440732714abdfccedb266861cf8078fde76d5596689e7ca92784f8df025ad90ad2c73f01a75bfa8a6244c9c940272bad9d23f01", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/309209043594ca48ad75dc9162e7e9ec7062ad7cbf3b6e28377b0f26bf0bf44bfbd4ba5cbb71bcbcabd2b77773eeb1c65c1d0be06131dffa22a1e9914c21a4af"} 17:55:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:55:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:55:15 INFO - Contents: 17:55:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c872da15aa2dffdd46f2e4e45d6116963be05fe30a61174c875bf4a6df7bb311fb39ebde6d6ec502c72fedfcee11fa9ff74d9eb13f4d566f5968a41ef464812b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa98b2a24779185efa36acf4f440732714abdfccedb266861cf8078fde76d5596689e7ca92784f8df025ad90ad2c73f01a75bfa8a6244c9c940272bad9d23f01", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/309209043594ca48ad75dc9162e7e9ec7062ad7cbf3b6e28377b0f26bf0bf44bfbd4ba5cbb71bcbcabd2b77773eeb1c65c1d0be06131dffa22a1e9914c21a4af"} 17:55:15 INFO - Running post-run listener: copy_logs_to_upload_dir 17:55:15 INFO - Copying logs to upload dir... 17:55:15 INFO - mkdir: /builds/slave/test/build/upload/logs 17:55:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.438759 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-10-24 17:55:15.679904) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 17:55:15.684806) ========= 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=41a7e32711b8e08598a63237000001d6-1477355680.274963-1024987003 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/c872da15aa2dffdd46f2e4e45d6116963be05fe30a61174c875bf4a6df7bb311fb39ebde6d6ec502c72fedfcee11fa9ff74d9eb13f4d566f5968a41ef464812b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa98b2a24779185efa36acf4f440732714abdfccedb266861cf8078fde76d5596689e7ca92784f8df025ad90ad2c73f01a75bfa8a6244c9c940272bad9d23f01", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/309209043594ca48ad75dc9162e7e9ec7062ad7cbf3b6e28377b0f26bf0bf44bfbd4ba5cbb71bcbcabd2b77773eeb1c65c1d0be06131dffa22a1e9914c21a4af"} build_url:https://queue.taskcluster.net/v1/task/TtKKmwt6Q3GTL0On12R00Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011473 build_url: 'https://queue.taskcluster.net/v1/task/TtKKmwt6Q3GTL0On12R00Q/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/c872da15aa2dffdd46f2e4e45d6116963be05fe30a61174c875bf4a6df7bb311fb39ebde6d6ec502c72fedfcee11fa9ff74d9eb13f4d566f5968a41ef464812b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa98b2a24779185efa36acf4f440732714abdfccedb266861cf8078fde76d5596689e7ca92784f8df025ad90ad2c73f01a75bfa8a6244c9c940272bad9d23f01", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/309209043594ca48ad75dc9162e7e9ec7062ad7cbf3b6e28377b0f26bf0bf44bfbd4ba5cbb71bcbcabd2b77773eeb1c65c1d0be06131dffa22a1e9914c21a4af"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 17:55:15.710663) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:55:15.711017) ========= 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=41a7e32711b8e08598a63237000001d6-1477355680.274963-1024987003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:55:15.795196) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 17:55:15.796581) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 17:55:15.796957) ========= ========= Total master_lag: 0.19 =========