builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-043 starttime: 1484247951.52 results: success (0) buildid: 20170112091316 builduid: 0b78e5e893094ac2b06f6f3da233ab5b revision: 0688f0bd4f534fd3f6d6cae3006c21966fd340bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 11:05:51.524945) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 11:05:51.525385) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 11:05:51.525656) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 11:05:51.540790) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 11:05:51.541098) ========= 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=d2a8c569965ab8367867b893000001a1-1484247951.510518-1121475325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-12 11:05:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 115M=0s 2017-01-12 11:05:52 (115 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.091162 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 11:05:51.646296) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 11:05:51.646607) ========= 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=d2a8c569965ab8367867b893000001a1-1484247951.510518-1121475325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014309 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 11:05:51.696182) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-12 11:05:51.696538) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0688f0bd4f534fd3f6d6cae3006c21966fd340bc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0688f0bd4f534fd3f6d6cae3006c21966fd340bc --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=d2a8c569965ab8367867b893000001a1-1484247951.510518-1121475325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-12 11:05:52,414 truncating revision to first 12 chars 2017-01-12 11:05:52,414 Setting DEBUG logging. 2017-01-12 11:05:52,414 attempt 1/10 2017-01-12 11:05:52,414 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0688f0bd4f53?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-12 11:05:53,554 unpacking tar archive at: mozilla-beta-0688f0bd4f53/testing/mozharness/ program finished with exit code 0 elapsedTime=1.449613 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-12 11:05:53.159970) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 11:05:53.160312) ========= script_repo_revision: 0688f0bd4f534fd3f6d6cae3006c21966fd340bc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 11:05:53.160751) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 11:05:53.161018) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 11:05:53.169543) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-01-12 11:05:53.169878) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1484247951.510518-1121475325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:05:53 INFO - MultiFileLogger online at 20170112 11:05:53 in /builds/slave/test 11:05:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:05:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:05:53 INFO - {'append_to_log': False, 11:05:53 INFO - 'base_work_dir': '/builds/slave/test', 11:05:53 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:05:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:05:53 INFO - 'branch': 'Mozilla-Beta', 11:05:53 INFO - 'buildbot_json_path': 'buildprops.json', 11:05:53 INFO - 'config_files': ('talos/linux_config.py',), 11:05:53 INFO - 'default_actions': ('clobber', 11:05:53 INFO - 'read-buildbot-config', 11:05:53 INFO - 'download-and-extract', 11:05:53 INFO - 'populate-webroot', 11:05:53 INFO - 'create-virtualenv', 11:05:53 INFO - 'install', 11:05:53 INFO - 'run-tests'), 11:05:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:05:53 INFO - 'download_minidump_stackwalk': True, 11:05:53 INFO - 'download_symbols': 'ondemand', 11:05:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:05:53 INFO - 'tooltool.py': '/tools/tooltool.py', 11:05:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:05:53 INFO - '/tools/misc-python/virtualenv.py')}, 11:05:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:05:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:05:53 INFO - 'installer_path': 'installer.exe', 11:05:53 INFO - 'log_level': 'info', 11:05:53 INFO - 'log_name': 'talos', 11:05:53 INFO - 'log_to_console': True, 11:05:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:05:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:05:53 INFO - 'opt_config_files': (), 11:05:53 INFO - 'pip_index': False, 11:05:53 INFO - 'sps_profile': False, 11:05:53 INFO - 'sps_profile_interval': 0, 11:05:53 INFO - 'suite': 'dromaeojs', 11:05:53 INFO - 'system_bits': '32', 11:05:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:05:53 INFO - 'title': 'talos-linux64-ix-043', 11:05:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:05:53 INFO - 'use_talos_json': True, 11:05:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:05:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:05:53 INFO - 'work_dir': 'build'} 11:05:53 INFO - [mozharness: 2017-01-12 19:05:53.983464Z] Running clobber step. 11:05:53 INFO - Running pre-action listener: _resource_record_pre_action 11:05:53 INFO - Running main action method: clobber 11:05:53 INFO - rmtree: /builds/slave/test/build 11:05:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:05:55 INFO - Running post-action listener: _resource_record_post_action 11:05:55 INFO - [mozharness: 2017-01-12 19:05:55.031880Z] Finished clobber step (success) 11:05:55 INFO - [mozharness: 2017-01-12 19:05:55.031979Z] Running read-buildbot-config step. 11:05:55 INFO - Running pre-action listener: _resource_record_pre_action 11:05:55 INFO - Running main action method: read_buildbot_config 11:05:55 INFO - Using buildbot properties: 11:05:55 INFO - { 11:05:55 INFO - "project": "", 11:05:55 INFO - "product": "firefox", 11:05:55 INFO - "script_repo_revision": "production", 11:05:55 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 11:05:55 INFO - "repository": "", 11:05:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 11:05:55 INFO - "buildid": "20170112091316", 11:05:55 INFO - "pgo_build": "True", 11:05:55 INFO - "basedir": "/builds/slave/test", 11:05:55 INFO - "buildnumber": 91, 11:05:55 INFO - "slavename": "talos-linux64-ix-043", 11:05:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:05:55 INFO - "platform": "ubuntu64_hw", 11:05:55 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:05:55 INFO - "branch": "mozilla-beta", 11:05:55 INFO - "repo_path": "releases/mozilla-beta", 11:05:55 INFO - "revision": "0688f0bd4f534fd3f6d6cae3006c21966fd340bc", 11:05:55 INFO - "stage_platform": "linux64-pgo", 11:05:55 INFO - "builduid": "0b78e5e893094ac2b06f6f3da233ab5b", 11:05:55 INFO - "slavebuilddir": "test" 11:05:55 INFO - } 11:05:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/LnMrit2RSa-UWUWWFHMH4Q/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2. 11:05:55 INFO - Running post-action listener: _resource_record_post_action 11:05:55 INFO - [mozharness: 2017-01-12 19:05:55.034419Z] Finished read-buildbot-config step (success) 11:05:55 INFO - [mozharness: 2017-01-12 19:05:55.034508Z] Running download-and-extract step. 11:05:55 INFO - Running pre-action listener: _resource_record_pre_action 11:05:55 INFO - Running main action method: download_and_extract 11:05:55 INFO - mkdir: /builds/slave/test/build/tests 11:05: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')]} 11:05:55 INFO - trying https://queue.taskcluster.net/v1/task/LnMrit2RSa-UWUWWFHMH4Q/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 11:05:55 INFO - Downloading https://queue.taskcluster.net/v1/task/LnMrit2RSa-UWUWWFHMH4Q/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 11:05:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LnMrit2RSa-UWUWWFHMH4Q/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:05:55 INFO - Downloaded 1327 bytes. 11:05:55 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 11:05:55 INFO - Using the following test package requirements: 11:05:55 INFO - {u'common': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 11:05:55 INFO - u'cppunittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 11:05:55 INFO - u'firefox-51.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:05:55 INFO - u'gtest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 11:05:55 INFO - u'firefox-51.0.en-US.linux-x86_64.gtest.tests.zip'], 11:05:55 INFO - u'jittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 11:05:55 INFO - u'jsshell-linux-x86_64.zip'], 11:05:55 INFO - u'mochitest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 11:05:55 INFO - u'firefox-51.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:05:55 INFO - u'mozbase': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 11:05:55 INFO - u'reftest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 11:05:55 INFO - u'firefox-51.0.en-US.linux-x86_64.reftest.tests.zip'], 11:05:55 INFO - u'talos': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 11:05:55 INFO - u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'], 11:05:55 INFO - u'web-platform': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 11:05:55 INFO - u'firefox-51.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:05:55 INFO - u'xpcshell': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 11:05:55 INFO - u'firefox-51.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:05:55 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:05:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LnMrit2RSa-UWUWWFHMH4Q/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 11:05:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LnMrit2RSa-UWUWWFHMH4Q/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:05:55 INFO - Fetch https://queue.taskcluster.net/v1/task/LnMrit2RSa-UWUWWFHMH4Q/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 11:05:56 INFO - Expected file size: 21972350 11:06:00 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:06:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LnMrit2RSa-UWUWWFHMH4Q/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 11:06:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LnMrit2RSa-UWUWWFHMH4Q/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:06:00 INFO - Fetch https://queue.taskcluster.net/v1/task/LnMrit2RSa-UWUWWFHMH4Q/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 11:06:01 INFO - Expected file size: 21972350 11:06:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LnMrit2RSa-UWUWWFHMH4Q/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip 11:06:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LnMrit2RSa-UWUWWFHMH4Q/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:06:05 INFO - Fetch https://queue.taskcluster.net/v1/task/LnMrit2RSa-UWUWWFHMH4Q/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip into memory 11:06:06 INFO - Expected file size: 14414089 11:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:06 INFO - trying https://queue.taskcluster.net/v1/task/LnMrit2RSa-UWUWWFHMH4Q/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 11:06:06 INFO - Downloading https://queue.taskcluster.net/v1/task/LnMrit2RSa-UWUWWFHMH4Q/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 11:06:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LnMrit2RSa-UWUWWFHMH4Q/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:06:07 INFO - Downloaded 56995701 bytes. 11:06:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LnMrit2RSa-UWUWWFHMH4Q/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 11:06:07 INFO - mkdir: /builds/slave/test/properties 11:06:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:06:07 INFO - Writing to file /builds/slave/test/properties/build_url 11:06:07 INFO - Contents: 11:06:07 INFO - build_url:https://queue.taskcluster.net/v1/task/LnMrit2RSa-UWUWWFHMH4Q/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 11:06:08 INFO - Running post-action listener: _resource_record_post_action 11:06:08 INFO - Running post-action listener: set_extra_try_arguments 11:06:08 INFO - [mozharness: 2017-01-12 19:06:08.629341Z] Finished download-and-extract step (success) 11:06:08 INFO - [mozharness: 2017-01-12 19:06:08.629569Z] Running populate-webroot step. 11:06:08 INFO - Running pre-action listener: _resource_record_pre_action 11:06:08 INFO - Running main action method: populate_webroot 11:06:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:06:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:06:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:06:08 INFO - '--tppagecycles', 11:06:08 INFO - '7'], 11:06:08 INFO - 'tests': ['tsvgm']}}, 11:06:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:06:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:06:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:06:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:06:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:06:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:06:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:08 INFO - 'talos_options': ['--disable-e10s'], 11:06:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:06:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:06:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:08 INFO - 'talos_options': ['--disable-e10s'], 11:06:08 INFO - 'tests': ['damp', 'tps']}, 11:06:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:08 INFO - 'tests': ['damp', 'tps']}, 11:06:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:06:08 INFO - 'tests': ['dromaeo_dom']}, 11:06:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:06:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:06:08 INFO - 'tests': ['basic_compositor_video']}, 11:06:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:06:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:06:08 INFO - 'tests': ['a11yr', 11:06:08 INFO - 'ts_paint', 11:06:08 INFO - 'tpaint', 11:06:08 INFO - 'sessionrestore', 11:06:08 INFO - 'sessionrestore_no_auto_restore', 11:06:08 INFO - 'tabpaint']}, 11:06:08 INFO - 'other-e10s': {'tests': ['a11yr', 11:06:08 INFO - 'ts_paint', 11:06:08 INFO - 'tpaint', 11:06:08 INFO - 'sessionrestore', 11:06:08 INFO - 'sessionrestore_no_auto_restore', 11:06:08 INFO - 'tabpaint']}, 11:06:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:06:08 INFO - 'ts_paint', 11:06:08 INFO - 'tpaint', 11:06:08 INFO - 'sessionrestore', 11:06:08 INFO - 'sessionrestore_no_auto_restore', 11:06:08 INFO - 'tabpaint']}, 11:06:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:06:08 INFO - 'ts_paint', 11:06:08 INFO - 'tpaint', 11:06:08 INFO - 'sessionrestore', 11:06:08 INFO - 'sessionrestore_no_auto_restore', 11:06:08 INFO - 'tabpaint']}, 11:06:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:06:08 INFO - 'tests': ['a11yr', 11:06:08 INFO - 'ts_paint', 11:06:08 INFO - 'tpaint', 11:06:08 INFO - 'sessionrestore', 11:06:08 INFO - 'sessionrestore_no_auto_restore', 11:06:08 INFO - 'tabpaint']}, 11:06:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:06:08 INFO - 'tests': ['a11yr', 11:06:08 INFO - 'ts_paint', 11:06:08 INFO - 'tpaint', 11:06:08 INFO - 'sessionrestore', 11:06:08 INFO - 'sessionrestore_no_auto_restore', 11:06:08 INFO - 'tabpaint']}, 11:06:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:06:08 INFO - 'tests': ['tsvgx', 11:06:08 INFO - 'tsvgr_opacity', 11:06:08 INFO - 'tart', 11:06:08 INFO - 'tscrollx', 11:06:08 INFO - 'cart']}, 11:06:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:06:08 INFO - 'tsvgr_opacity', 11:06:08 INFO - 'tart', 11:06:08 INFO - 'tscrollx', 11:06:08 INFO - 'cart']}, 11:06:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:08 INFO - 'talos_options': ['--disable-e10s'], 11:06:08 INFO - 'tests': ['tp5o']}, 11:06:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:08 INFO - 'tests': ['tp5o']}, 11:06:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:08 INFO - 'talos_options': ['--disable-e10s', 11:06:08 INFO - '--xperf_path', 11:06:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:06:08 INFO - 'tests': ['tp5n']}, 11:06:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:08 INFO - 'talos_options': ['--xperf_path', 11:06:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:06:08 INFO - 'tests': ['tp5n']}}, 11:06:08 INFO - 'talos.zip': {'path': '', 11:06:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:06:08 INFO - Running post-action listener: _resource_record_post_action 11:06:08 INFO - [mozharness: 2017-01-12 19:06:08.651295Z] Finished populate-webroot step (success) 11:06:08 INFO - [mozharness: 2017-01-12 19:06:08.651389Z] Running create-virtualenv step. 11:06:08 INFO - Running pre-action listener: _resource_record_pre_action 11:06:08 INFO - Running main action method: create_virtualenv 11:06:08 INFO - Creating virtualenv /builds/slave/test/build/venv 11:06:08 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 11:06:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:06:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:06:08 INFO - Using real prefix '/usr' 11:06:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:06:09 INFO - Installing distribute.............................................................................................................................................................................................done. 11:06:11 INFO - Installing pip.................done. 11:06:11 INFO - Return code: 0 11:06:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:06: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')]} 11:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06: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')]} 11:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:11 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 0x7fb8035fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b5f60>, '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 0x15b6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b71d0>, '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': 'd2a8c569965ab8367867b893000001a1-1484247951.510518-1121475325', '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 11:06:11 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 11:06:11 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 11:06:11 INFO - Using env: {'DISPLAY': ':0', 11:06:11 INFO - 'HOME': '/home/cltbld', 11:06:11 INFO - 'LANG': 'en_US.UTF-8', 11:06:11 INFO - 'LANGUAGE': 'en_US:en', 11:06:11 INFO - 'LOGNAME': 'cltbld', 11:06:11 INFO - 'MAIL': '/var/mail/cltbld', 11:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:11 INFO - 'MOZ_NO_REMOTE': '1', 11:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:11 INFO - 'NO_EM_RESTART': '1', 11:06:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:11 INFO - 'PWD': '/builds/slave/test', 11:06:11 INFO - 'SHELL': '/bin/bash', 11:06:11 INFO - 'SHLVL': '1', 11:06:11 INFO - 'TERM': 'linux', 11:06:11 INFO - 'TMOUT': '86400', 11:06:11 INFO - 'USER': 'cltbld', 11:06:11 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1484247951.510518-1121475325', 11:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:11 INFO - '_': '/tools/buildbot/bin/python'} 11:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:11 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 11:06:11 INFO - Cleaning up... 11:06:11 INFO - Return code: 0 11:06:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:06: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')]} 11:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06: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')]} 11:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:11 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 0x7fb8035fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b5f60>, '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 0x15b6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b71d0>, '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': 'd2a8c569965ab8367867b893000001a1-1484247951.510518-1121475325', '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 11:06:11 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 11:06:11 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 11:06:11 INFO - Using env: {'DISPLAY': ':0', 11:06:11 INFO - 'HOME': '/home/cltbld', 11:06:11 INFO - 'LANG': 'en_US.UTF-8', 11:06:11 INFO - 'LANGUAGE': 'en_US:en', 11:06:11 INFO - 'LOGNAME': 'cltbld', 11:06:11 INFO - 'MAIL': '/var/mail/cltbld', 11:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:11 INFO - 'MOZ_NO_REMOTE': '1', 11:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:11 INFO - 'NO_EM_RESTART': '1', 11:06:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:11 INFO - 'PWD': '/builds/slave/test', 11:06:11 INFO - 'SHELL': '/bin/bash', 11:06:11 INFO - 'SHLVL': '1', 11:06:11 INFO - 'TERM': 'linux', 11:06:11 INFO - 'TMOUT': '86400', 11:06:11 INFO - 'USER': 'cltbld', 11:06:11 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1484247951.510518-1121475325', 11:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:11 INFO - '_': '/tools/buildbot/bin/python'} 11:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:11 INFO - Downloading/unpacking psutil>=3.1.1 11:06:11 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 11:06:11 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 11:06:11 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 11:06:11 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 11:06:11 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 11:06:11 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 11:06:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:06:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:06:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:06:13 INFO - Installing collected packages: psutil 11:06:13 INFO - Running setup.py install for psutil 11:06:13 INFO - building 'psutil._psutil_linux' extension 11:06:13 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 11:06:14 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 11:06:14 INFO - building 'psutil._psutil_posix' extension 11:06:14 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 11:06:14 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 11:06:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:06:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:06:14 INFO - Successfully installed psutil 11:06:14 INFO - Cleaning up... 11:06:14 INFO - Return code: 0 11:06:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:06: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')]} 11:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06: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')]} 11:06:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:14 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 0x7fb8035fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b5f60>, '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 0x15b6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b71d0>, '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': 'd2a8c569965ab8367867b893000001a1-1484247951.510518-1121475325', '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 11:06:14 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 11:06:14 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 11:06:14 INFO - Using env: {'DISPLAY': ':0', 11:06:14 INFO - 'HOME': '/home/cltbld', 11:06:14 INFO - 'LANG': 'en_US.UTF-8', 11:06:14 INFO - 'LANGUAGE': 'en_US:en', 11:06:14 INFO - 'LOGNAME': 'cltbld', 11:06:14 INFO - 'MAIL': '/var/mail/cltbld', 11:06:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:14 INFO - 'MOZ_NO_REMOTE': '1', 11:06:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:14 INFO - 'NO_EM_RESTART': '1', 11:06:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:14 INFO - 'PWD': '/builds/slave/test', 11:06:14 INFO - 'SHELL': '/bin/bash', 11:06:14 INFO - 'SHLVL': '1', 11:06:14 INFO - 'TERM': 'linux', 11:06:14 INFO - 'TMOUT': '86400', 11:06:14 INFO - 'USER': 'cltbld', 11:06:14 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1484247951.510518-1121475325', 11:06:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:14 INFO - '_': '/tools/buildbot/bin/python'} 11:06:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:06:14 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 11:06:14 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 11:06:14 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 11:06:14 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 11:06:14 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 11:06:14 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 11:06:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:06:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:06:16 INFO - Installing collected packages: mozsystemmonitor 11:06:16 INFO - Running setup.py install for mozsystemmonitor 11:06:16 INFO - Successfully installed mozsystemmonitor 11:06:16 INFO - Cleaning up... 11:06:16 INFO - Return code: 0 11:06:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:06:16 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')]} 11:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:16 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')]} 11:06:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:16 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 0x7fb8035fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b5f60>, '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 0x15b6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b71d0>, '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': 'd2a8c569965ab8367867b893000001a1-1484247951.510518-1121475325', '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 11:06:16 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 11:06:16 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 11:06:16 INFO - Using env: {'DISPLAY': ':0', 11:06:16 INFO - 'HOME': '/home/cltbld', 11:06:16 INFO - 'LANG': 'en_US.UTF-8', 11:06:16 INFO - 'LANGUAGE': 'en_US:en', 11:06:16 INFO - 'LOGNAME': 'cltbld', 11:06:16 INFO - 'MAIL': '/var/mail/cltbld', 11:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:16 INFO - 'MOZ_NO_REMOTE': '1', 11:06:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:16 INFO - 'NO_EM_RESTART': '1', 11:06:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:16 INFO - 'PWD': '/builds/slave/test', 11:06:16 INFO - 'SHELL': '/bin/bash', 11:06:16 INFO - 'SHLVL': '1', 11:06:16 INFO - 'TERM': 'linux', 11:06:16 INFO - 'TMOUT': '86400', 11:06:16 INFO - 'USER': 'cltbld', 11:06:16 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1484247951.510518-1121475325', 11:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:16 INFO - '_': '/tools/buildbot/bin/python'} 11:06:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:17 INFO - Downloading/unpacking jsonschema==2.5.1 11:06:17 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 11:06:17 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 11:06:17 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 11:06:17 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 11:06:17 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 11:06:17 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 11:06:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:06:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:06:19 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 11:06:19 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 11:06:19 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 11:06:19 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 11:06:19 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 11:06:19 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 11:06:19 INFO - Downloading functools32-3.2.3-2.tar.gz 11:06:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:06:19 INFO - warning: no files found matching '*.txt' 11:06:19 INFO - no previously-included directories found matching 'build' 11:06:19 INFO - no previously-included directories found matching 'dist' 11:06:19 INFO - no previously-included directories found matching '.git*' 11:06:19 INFO - Installing collected packages: jsonschema, functools32 11:06:19 INFO - Running setup.py install for functools32 11:06:19 INFO - warning: no files found matching '*.txt' 11:06:19 INFO - no previously-included directories found matching 'build' 11:06:19 INFO - no previously-included directories found matching 'dist' 11:06:19 INFO - no previously-included directories found matching '.git*' 11:06:19 INFO - Successfully installed jsonschema functools32 11:06:19 INFO - Cleaning up... 11:06:19 INFO - Return code: 0 11:06:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:06:19 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')]} 11:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:19 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')]} 11:06:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:19 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 0x7fb8035fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b5f60>, '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 0x15b6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b71d0>, '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': 'd2a8c569965ab8367867b893000001a1-1484247951.510518-1121475325', '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 11:06:19 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 11:06:19 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 11:06:19 INFO - Using env: {'DISPLAY': ':0', 11:06:19 INFO - 'HOME': '/home/cltbld', 11:06:19 INFO - 'LANG': 'en_US.UTF-8', 11:06:19 INFO - 'LANGUAGE': 'en_US:en', 11:06:19 INFO - 'LOGNAME': 'cltbld', 11:06:19 INFO - 'MAIL': '/var/mail/cltbld', 11:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:19 INFO - 'MOZ_NO_REMOTE': '1', 11:06:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:19 INFO - 'NO_EM_RESTART': '1', 11:06:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:19 INFO - 'PWD': '/builds/slave/test', 11:06:19 INFO - 'SHELL': '/bin/bash', 11:06:19 INFO - 'SHLVL': '1', 11:06:19 INFO - 'TERM': 'linux', 11:06:19 INFO - 'TMOUT': '86400', 11:06:19 INFO - 'USER': 'cltbld', 11:06:19 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1484247951.510518-1121475325', 11:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:19 INFO - '_': '/tools/buildbot/bin/python'} 11:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:06:19 INFO - Cleaning up... 11:06:19 INFO - Return code: 0 11:06:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:06:19 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')]} 11:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:19 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')]} 11:06:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:19 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 0x7fb8035fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b5f60>, '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 0x15b6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b71d0>, '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': 'd2a8c569965ab8367867b893000001a1-1484247951.510518-1121475325', '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 11:06:19 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 11:06:19 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 11:06:19 INFO - Using env: {'DISPLAY': ':0', 11:06:19 INFO - 'HOME': '/home/cltbld', 11:06:19 INFO - 'LANG': 'en_US.UTF-8', 11:06:19 INFO - 'LANGUAGE': 'en_US:en', 11:06:19 INFO - 'LOGNAME': 'cltbld', 11:06:19 INFO - 'MAIL': '/var/mail/cltbld', 11:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:19 INFO - 'MOZ_NO_REMOTE': '1', 11:06:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:19 INFO - 'NO_EM_RESTART': '1', 11:06:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:19 INFO - 'PWD': '/builds/slave/test', 11:06:19 INFO - 'SHELL': '/bin/bash', 11:06:19 INFO - 'SHLVL': '1', 11:06:19 INFO - 'TERM': 'linux', 11:06:19 INFO - 'TMOUT': '86400', 11:06:19 INFO - 'USER': 'cltbld', 11:06:19 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1484247951.510518-1121475325', 11:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:19 INFO - '_': '/tools/buildbot/bin/python'} 11:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:19 INFO - Downloading/unpacking blobuploader==1.2.4 11:06:19 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 11:06:19 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 11:06:19 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 11:06:19 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 11:06:19 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 11:06:19 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 11:06:21 INFO - Downloading blobuploader-1.2.4.tar.gz 11:06:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:06:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:06:21 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 11:06:21 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 11:06:21 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 11:06:21 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 11:06:21 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 11:06:21 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 11:06:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:06:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:22 INFO - Downloading docopt-0.6.1.tar.gz 11:06:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:06:22 INFO - Installing collected packages: blobuploader, requests, docopt 11:06:22 INFO - Running setup.py install for blobuploader 11:06:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:06:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:06:22 INFO - Running setup.py install for requests 11:06:23 INFO - Running setup.py install for docopt 11:06:23 INFO - Successfully installed blobuploader requests docopt 11:06:23 INFO - Cleaning up... 11:06:23 INFO - Return code: 0 11:06:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:23 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 0x7fb8035fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b5f60>, '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 0x15b6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b71d0>, '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': 'd2a8c569965ab8367867b893000001a1-1484247951.510518-1121475325', '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 11:06:23 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 11:06:23 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 11:06:23 INFO - Using env: {'DISPLAY': ':0', 11:06:23 INFO - 'HOME': '/home/cltbld', 11:06:23 INFO - 'LANG': 'en_US.UTF-8', 11:06:23 INFO - 'LANGUAGE': 'en_US:en', 11:06:23 INFO - 'LOGNAME': 'cltbld', 11:06:23 INFO - 'MAIL': '/var/mail/cltbld', 11:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:23 INFO - 'MOZ_NO_REMOTE': '1', 11:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:23 INFO - 'NO_EM_RESTART': '1', 11:06:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:23 INFO - 'PWD': '/builds/slave/test', 11:06:23 INFO - 'SHELL': '/bin/bash', 11:06:23 INFO - 'SHLVL': '1', 11:06:23 INFO - 'TERM': 'linux', 11:06:23 INFO - 'TMOUT': '86400', 11:06:23 INFO - 'USER': 'cltbld', 11:06:23 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1484247951.510518-1121475325', 11:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:23 INFO - '_': '/tools/buildbot/bin/python'} 11:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:06:23 INFO - Running setup.py (path:/tmp/pip-kAfgdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:06:23 INFO - Running setup.py (path:/tmp/pip-9DJMPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:06:23 INFO - Running setup.py (path:/tmp/pip-OnjjLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:06:23 INFO - Running setup.py (path:/tmp/pip-IZ0YCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:06:23 INFO - Running setup.py (path:/tmp/pip-EM9B_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:06:23 INFO - Running setup.py (path:/tmp/pip-_Iz3nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:06:23 INFO - Running setup.py (path:/tmp/pip-kVIJqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:06:24 INFO - Running setup.py (path:/tmp/pip-wvIfYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:06:24 INFO - Running setup.py (path:/tmp/pip-M1mbeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:06:24 INFO - Running setup.py (path:/tmp/pip-PJoekp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:06:24 INFO - Running setup.py (path:/tmp/pip-kVzHw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:06:24 INFO - Running setup.py (path:/tmp/pip-BaRZic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:06:24 INFO - Running setup.py (path:/tmp/pip-gCoOaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:06:24 INFO - Running setup.py (path:/tmp/pip-gf2sNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:24 INFO - Running setup.py (path:/tmp/pip-Kek0SV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:06:24 INFO - Running setup.py (path:/tmp/pip-p_kWMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:06:24 INFO - Running setup.py (path:/tmp/pip-gEjMXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:06:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:06:24 INFO - Running setup.py install for manifestparser 11:06:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:06:24 INFO - Running setup.py install for mozcrash 11:06:24 INFO - Running setup.py install for mozdebug 11:06:25 INFO - Running setup.py install for mozdevice 11:06:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:06:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:06:25 INFO - Running setup.py install for mozfile 11:06:25 INFO - Running setup.py install for mozhttpd 11:06:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:06:25 INFO - Running setup.py install for mozinfo 11:06:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:06:25 INFO - Running setup.py install for mozInstall 11:06:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:06:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:06:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:06:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:06:25 INFO - Running setup.py install for mozleak 11:06:25 INFO - Running setup.py install for mozlog 11:06:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:06:25 INFO - Running setup.py install for moznetwork 11:06:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:06:25 INFO - Running setup.py install for mozprocess 11:06:26 INFO - Running setup.py install for mozprofile 11:06:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:06:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:06:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:06:26 INFO - Running setup.py install for mozrunner 11:06:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:06:26 INFO - Running setup.py install for mozscreenshot 11:06:26 INFO - Running setup.py install for moztest 11:06:26 INFO - Running setup.py install for mozversion 11:06:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:06:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:06:26 INFO - Cleaning up... 11:06:26 INFO - Return code: 0 11:06:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:26 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 0x7fb8035fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b5f60>, '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 0x15b6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b71d0>, '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': 'd2a8c569965ab8367867b893000001a1-1484247951.510518-1121475325', '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 11:06:26 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 11:06:26 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 11:06:26 INFO - Using env: {'DISPLAY': ':0', 11:06:26 INFO - 'HOME': '/home/cltbld', 11:06:26 INFO - 'LANG': 'en_US.UTF-8', 11:06:26 INFO - 'LANGUAGE': 'en_US:en', 11:06:26 INFO - 'LOGNAME': 'cltbld', 11:06:26 INFO - 'MAIL': '/var/mail/cltbld', 11:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:26 INFO - 'MOZ_NO_REMOTE': '1', 11:06:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:26 INFO - 'NO_EM_RESTART': '1', 11:06:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:26 INFO - 'PWD': '/builds/slave/test', 11:06:26 INFO - 'SHELL': '/bin/bash', 11:06:26 INFO - 'SHLVL': '1', 11:06:26 INFO - 'TERM': 'linux', 11:06:26 INFO - 'TMOUT': '86400', 11:06:26 INFO - 'USER': 'cltbld', 11:06:26 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1484247951.510518-1121475325', 11:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:26 INFO - '_': '/tools/buildbot/bin/python'} 11:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:06:26 INFO - Running setup.py (path:/tmp/pip-Fv_6tU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:06:26 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)) 11:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:06:26 INFO - Running setup.py (path:/tmp/pip-mzAXPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:06:26 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)) 11:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:06:26 INFO - Running setup.py (path:/tmp/pip-pwW12d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:06:26 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)) 11:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:06:27 INFO - Running setup.py (path:/tmp/pip-pguZUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:06:27 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)) 11:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:06:27 INFO - Running setup.py (path:/tmp/pip-TDJri1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:06:27 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)) 11:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:06:27 INFO - Running setup.py (path:/tmp/pip-K4oA38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:06:27 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)) 11:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:06:27 INFO - Running setup.py (path:/tmp/pip-aZkQ9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:06:27 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)) 11:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:06:27 INFO - Running setup.py (path:/tmp/pip-EHdPLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:06:27 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)) 11:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:06:27 INFO - Running setup.py (path:/tmp/pip-D0_66K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:06:27 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)) 11:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:06:27 INFO - Running setup.py (path:/tmp/pip-G7F3qn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:06:27 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)) 11:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:06:27 INFO - Running setup.py (path:/tmp/pip-vaV78P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:06:27 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)) 11:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:06:27 INFO - Running setup.py (path:/tmp/pip-8DXybU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:06:27 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)) 11:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:06:27 INFO - Running setup.py (path:/tmp/pip-iIDFac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:06:27 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)) 11:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:06:27 INFO - Running setup.py (path:/tmp/pip-35WDm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:06:27 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)) 11:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:27 INFO - Running setup.py (path:/tmp/pip-3wBC5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:27 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)) 11:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:06:27 INFO - Running setup.py (path:/tmp/pip-7I5yP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:06:27 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)) 11:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:06:27 INFO - Running setup.py (path:/tmp/pip-YszVKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:06:28 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)) 11:06:28 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)) 11:06:28 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)) 11:06:28 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)) 11:06:28 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)) 11:06:28 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)) 11:06:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:06:28 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 11:06:28 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 11:06:28 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 11:06:28 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 11:06:28 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 11:06:28 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 11:06:30 INFO - Downloading blessings-1.6.tar.gz 11:06:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:06:30 INFO - Installing collected packages: blessings 11:06:30 INFO - Running setup.py install for blessings 11:06:30 INFO - Successfully installed blessings 11:06:30 INFO - Cleaning up... 11:06:30 INFO - Return code: 0 11:06:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:06:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:06:30 INFO - Reading from file tmpfile_stdout 11:06:30 INFO - Current package versions: 11:06:30 INFO - argparse == 1.2.1 11:06:30 INFO - blessings == 1.6 11:06:30 INFO - blobuploader == 1.2.4 11:06:30 INFO - docopt == 0.6.1 11:06:30 INFO - functools32 == 3.2.3-2 11:06:30 INFO - jsonschema == 2.5.1 11:06:30 INFO - manifestparser == 1.1 11:06:30 INFO - mozInstall == 1.12 11:06:30 INFO - mozcrash == 0.17 11:06:30 INFO - mozdebug == 0.1 11:06:30 INFO - mozdevice == 0.48 11:06:30 INFO - mozfile == 1.2 11:06:30 INFO - mozhttpd == 0.7 11:06:30 INFO - mozinfo == 0.9 11:06:30 INFO - mozleak == 0.1 11:06:30 INFO - mozlog == 3.4 11:06:30 INFO - moznetwork == 0.27 11:06:30 INFO - mozprocess == 0.23 11:06:30 INFO - mozprofile == 0.28 11:06:30 INFO - mozrunner == 6.12 11:06:30 INFO - mozscreenshot == 0.1 11:06:30 INFO - mozsystemmonitor == 0.3 11:06:30 INFO - moztest == 0.7 11:06:30 INFO - mozversion == 1.4 11:06:30 INFO - psutil == 3.1.1 11:06:30 INFO - requests == 1.2.3 11:06:30 INFO - wsgiref == 0.1.2 11:06:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:30 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 0x7fb8035fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b5f60>, '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 0x15b6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b71d0>, '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': 'd2a8c569965ab8367867b893000001a1-1484247951.510518-1121475325', '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 11:06:30 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 11:06:30 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 11:06:30 INFO - Using env: {'DISPLAY': ':0', 11:06:30 INFO - 'HOME': '/home/cltbld', 11:06:30 INFO - 'LANG': 'en_US.UTF-8', 11:06:30 INFO - 'LANGUAGE': 'en_US:en', 11:06:30 INFO - 'LOGNAME': 'cltbld', 11:06:30 INFO - 'MAIL': '/var/mail/cltbld', 11:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:30 INFO - 'MOZ_NO_REMOTE': '1', 11:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:30 INFO - 'NO_EM_RESTART': '1', 11:06:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:30 INFO - 'PWD': '/builds/slave/test', 11:06:30 INFO - 'SHELL': '/bin/bash', 11:06:30 INFO - 'SHLVL': '1', 11:06:30 INFO - 'TERM': 'linux', 11:06:30 INFO - 'TMOUT': '86400', 11:06:30 INFO - 'USER': 'cltbld', 11:06:30 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1484247951.510518-1121475325', 11:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:30 INFO - '_': '/tools/buildbot/bin/python'} 11:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:30 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)) 11:06:30 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)) 11:06:30 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)) 11:06:30 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)) 11:06:30 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)) 11:06:30 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)) 11:06:30 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)) 11:06:30 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)) 11:06:30 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)) 11:06:30 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)) 11:06:30 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)) 11:06:30 INFO - Cleaning up... 11:06:30 INFO - Return code: 0 11:06:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8035fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b5f60>, '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 0x15b6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b71d0>, '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': 'd2a8c569965ab8367867b893000001a1-1484247951.510518-1121475325', '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 11:06:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:06:30 INFO - Using env: {'DISPLAY': ':0', 11:06:30 INFO - 'HOME': '/home/cltbld', 11:06:30 INFO - 'LANG': 'en_US.UTF-8', 11:06:30 INFO - 'LANGUAGE': 'en_US:en', 11:06:30 INFO - 'LOGNAME': 'cltbld', 11:06:30 INFO - 'MAIL': '/var/mail/cltbld', 11:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:30 INFO - 'MOZ_NO_REMOTE': '1', 11:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:30 INFO - 'NO_EM_RESTART': '1', 11:06:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:30 INFO - 'PWD': '/builds/slave/test', 11:06:30 INFO - 'SHELL': '/bin/bash', 11:06:30 INFO - 'SHLVL': '1', 11:06:30 INFO - 'TERM': 'linux', 11:06:30 INFO - 'TMOUT': '86400', 11:06:30 INFO - 'USER': 'cltbld', 11:06:30 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1484247951.510518-1121475325', 11:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:30 INFO - '_': '/tools/buildbot/bin/python'} 11:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:06:30 INFO - Cleaning up... 11:06:30 INFO - Return code: 0 11:06:30 INFO - Running post-action listener: _resource_record_post_action 11:06:30 INFO - Running post-action listener: _start_resource_monitoring 11:06:30 INFO - Starting resource monitoring. 11:06:30 INFO - [mozharness: 2017-01-12 19:06:30.953533Z] Finished create-virtualenv step (success) 11:06:30 INFO - [mozharness: 2017-01-12 19:06:30.954029Z] Running install step. 11:06:30 INFO - Running pre-action listener: _resource_record_pre_action 11:06:30 INFO - Running main action method: install 11:06:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:06:31 INFO - Reading from file tmpfile_stdout 11:06:31 INFO - Detecting whether we're running mozinstall >=1.0... 11:06:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:06:31 INFO - Reading from file tmpfile_stdout 11:06:31 INFO - Output received: 11:06:31 INFO - Usage: mozinstall [options] installer 11:06:31 INFO - Options: 11:06:31 INFO - -h, --help show this help message and exit 11:06:31 INFO - -d DEST, --destination=DEST 11:06:31 INFO - Directory to install application into. [default: 11:06:31 INFO - "/builds/slave/test"] 11:06:31 INFO - --app=APP Application being installed. [default: firefox] 11:06:31 INFO - mkdir: /builds/slave/test/build/application 11:06:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:06:44 INFO - Reading from file tmpfile_stdout 11:06:44 INFO - Output received: 11:06:44 INFO - /builds/slave/test/build/application/firefox/firefox 11:06:44 INFO - Running post-action listener: _resource_record_post_action 11:06:44 INFO - [mozharness: 2017-01-12 19:06:44.757331Z] Finished install step (success) 11:06:44 INFO - [mozharness: 2017-01-12 19:06:44.757574Z] Running run-tests step. 11:06:44 INFO - Running pre-action listener: _resource_record_pre_action 11:06:44 INFO - Running main action method: run_tests 11:06:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:06:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:06:44 INFO - Python 2.7.3 11:06:44 INFO - Return code: 0 11:06:44 INFO - grabbing minidump binary from tooltool 11:06:44 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')]} 11:06:44 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 0x15b5f60>, '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 0x15b6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b71d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:06:44 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 11:06:44 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 11:06:44 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 11:06:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:06:44 INFO - Return code: 0 11:06:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:06:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:06:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:06:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:06:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:06:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LnMrit2RSa-UWUWWFHMH4Q/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 11:06:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LnMrit2RSa-UWUWWFHMH4Q/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 11:06:44 INFO - Using env: {'DISPLAY': ':0', 11:06:44 INFO - 'HOME': '/home/cltbld', 11:06:44 INFO - 'LANG': 'en_US.UTF-8', 11:06:44 INFO - 'LANGUAGE': 'en_US:en', 11:06:44 INFO - 'LOGNAME': 'cltbld', 11:06:44 INFO - 'MAIL': '/var/mail/cltbld', 11:06:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:06:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:44 INFO - 'MOZ_NO_REMOTE': '1', 11:06:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:44 INFO - 'NO_EM_RESTART': '1', 11:06:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:44 INFO - 'PWD': '/builds/slave/test', 11:06:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:06:44 INFO - 'SHELL': '/bin/bash', 11:06:44 INFO - 'SHLVL': '1', 11:06:44 INFO - 'TERM': 'linux', 11:06:44 INFO - 'TMOUT': '86400', 11:06:44 INFO - 'USER': 'cltbld', 11:06:44 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1484247951.510518-1121475325', 11:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:44 INFO - '_': '/tools/buildbot/bin/python'} 11:06:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LnMrit2RSa-UWUWWFHMH4Q/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 11:06:45 INFO - mozversion application_buildid: 20170112091316 11:06:45 INFO - mozversion application_changeset: 0688f0bd4f534fd3f6d6cae3006c21966fd340bc 11:06:45 INFO - mozversion application_display_name: Firefox 11:06:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:06:45 INFO - mozversion application_name: Firefox 11:06:45 INFO - mozversion application_remotingname: firefox 11:06:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:06:45 INFO - mozversion application_vendor: Mozilla 11:06:45 INFO - mozversion application_version: 51.0 11:06:45 INFO - mozversion platform_buildid: 20170112091316 11:06:45 INFO - mozversion platform_changeset: 0688f0bd4f534fd3f6d6cae3006c21966fd340bc 11:06:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:06:45 INFO - mozversion platform_version: 51.0 11:06:45 INFO - using testdate: 1484248005 11:06:45 INFO - actual date: 1484248005 11:06:45 INFO - starting webserver on 'localhost:51774' 11:06:45 INFO - SUITE-START | Running 2 tests 11:06:45 INFO - TEST-START | dromaeo_css 11:06:45 INFO - operating with platform_type : linux_ 11:06:45 INFO - Initialising browser for dromaeo_css test... 11:06:45 INFO - TEST-INFO | started process 24766 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmx15n4/profile http://localhost:51774/getInfo.html) 11:06:49 INFO - PROCESS | 24766 | __metrics Screen width/height:1600/1200 11:06:49 INFO - PROCESS | 24766 | colorDepth:24 11:06:49 INFO - PROCESS | 24766 | Browser inner width/height: 1024/697 11:06:49 INFO - PROCESS | 24766 | __metrics 11:06:50 INFO - PROCESS | 24766 | 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" 11:06:50 INFO - PROCESS | 24766 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:06:50 INFO - PROCESS | 24766 | console.error: PushService: 11:06:50 INFO - PROCESS | 24766 | stateChangeProcessEnqueue: Error transitioning state 11:06:50 INFO - PROCESS | 24766 | UnknownError 11:06:51 INFO - TEST-INFO | 24766: exit 0 11:06:51 INFO - Browser initialized. 11:06:51 INFO - Running cycle 1/1 for dromaeo_css test... 11:06:51 INFO - TEST-INFO | started process 24857 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmx15n4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:07:03 INFO - PROCESS | 24857 | RSS: Main: 143941632 11:07:03 INFO - PROCESS | 24857 | 11:07:54 INFO - PROCESS | 24857 | 1484248074063 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] 11:10:03 INFO - PROCESS | 24857 | Cycle 1(1): loaded http://localhost:51774/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51774/tests/dromaeo/cssquery-ext.html) 11:10:04 INFO - PROCESS | 24857 | RSS: Main: 230912000 11:10:04 INFO - PROCESS | 24857 | 11:13:06 INFO - PROCESS | 24857 | Cycle 1(1): loaded http://localhost:51774/tests/dromaeo/cssquery-ext.html (next: http://localhost:51774/tests/dromaeo/cssquery-jquery.html) 11:13:07 INFO - PROCESS | 24857 | RSS: Main: 229715968 11:13:07 INFO - PROCESS | 24857 | 11:16:09 INFO - PROCESS | 24857 | Cycle 1(1): loaded http://localhost:51774/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51774/tests/dromaeo/cssquery-mootools.html) 11:16:09 INFO - PROCESS | 24857 | RSS: Main: 216678400 11:16:09 INFO - PROCESS | 24857 | 11:19:11 INFO - PROCESS | 24857 | Cycle 1(1): loaded http://localhost:51774/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51774/tests/dromaeo/cssquery-prototype.html) 11:19:12 INFO - PROCESS | 24857 | RSS: Main: 215535616 11:19:12 INFO - PROCESS | 24857 | 11:22:14 INFO - PROCESS | 24857 | Cycle 1(1): loaded http://localhost:51774/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51774/tests/dromaeo/cssquery-yui.html) 11:22:15 INFO - PROCESS | 24857 | RSS: Main: 175239168 11:22:15 INFO - PROCESS | 24857 | 11:25:17 INFO - PROCESS | 24857 | Cycle 1(1): loaded http://localhost:51774/tests/dromaeo/cssquery-yui.html (next: http://localhost:51774/tests/dromaeo/cssquery-dojo.html) 11:25:17 INFO - PROCESS | 24857 | RSS: Main: 258584576 11:25:17 INFO - PROCESS | 24857 | 11:25:17 INFO - PROCESS | 24857 | __start_tp_report 11:25:17 INFO - PROCESS | 24857 | _x_x_mozilla_page_load 11:25:17 INFO - PROCESS | 24857 | _x_x_mozilla_page_load_details 11:25:17 INFO - PROCESS | 24857 | |i|pagename|runs| 11:25:17 INFO - PROCESS | 24857 | |0;dojo.html;3053.8167709937406;3088.2125058110187;3090.042086953045;3101.7673674474404;3122.8750849966004;5398.3521977362725;5470.398256191816;5481.506664400204;5488.780448782049;5495.20319553665;5544.029794785916;5587.580931430149;5608.317504748579;5609.439056094388;5644.125160600103;5051.343325367706;5078.542931136197;5118.795248190087;5131.769070391822;5170.327857378555;5017.473165317644;5147.639665223436;5164.561012313958;5172.250023746555;5174.663646862942;5001.299818025479;5023.196288593826;5043.218301163307;5044.596432285409;5072.9492705073035;5088.313077734514;5116.820911268125;5121.052605268;5172.672147687887;5178.300929374562;5006.5744411725045;5071.087204303224;5128.461511541309;5144.3312369392115;5169.276301317818;5238.92141617876;5290.788368465257;5438.320209973754;5472.151816468414;5514.228008078872;5858.443447872445;5882.176495290662;5884.882302353972;5965.821025369246;5973.492253158487;6010.519158467312;6014.729337179838;6016.789412370546;6018.939810601882;6024.21685180928;5379.542738867201;5403.135498320289;5415.458454154632;5420.430854760272;5471.124620060811;5958.165856780054;5983.132445795335;5991.400859913973;5995.370486098984;5995.790147344822;5737.8565535861935;5759.683217423082;5764.221830052889;5770.2498675171955;5775.711214439261;5693.28833895763;5742.7702891883855;5790.478856902899;5826.563007774349;5841.211436456024;5842.912356314659;5849.093390524476;5849.356570777211;5858.736356863951;5881.705914704247;5814.941850581525;5866.472017518444;5876.236089308362;5881.2942446906645;5889.411058894077;4377.3433984901885;4407.537208593051;4461.018575913294;4502.752348620857;4551.499335073206;3958.1094253793244;4003.1193137510286;4011.7392369495888;4022.959770402317;4047.7166598337835;5558.694271815089;5560.805371811967;5563.527100196528;5567.693776842312;5573.080441727069;5725.370209276976;5805.796797112081;5806.419358064244;5891.440313170242;5893.852653683693;5615.578831587565;5667.036603777367;5670.177824215466;5699.971500142473;5706.28671416073;5223.843284701465;5226.451222621646;5233.738313084331;5235.607329450307;5244.475552444801;5955.851103722268;6130.049842274455;6177.660228687465;6178.99999999991;6201.56589038772;5858;5925.377835327401;5929.822105336847;5988.431099045583;6035.78874739382;6166.229221347332;6166.907496387647;6172.598781079216;6175.166352542349;6186.505079593531;5921.289445266596;5922.911156332572;5924.674142922181;5940.198073260228;5972.8805423892145;5726.341470730919;5801.158831969256;5907.49786268172;5938.406159384027;5990.31111422192;5852.3269823969085;5909;5909.556783241188;5913.674747888907;5937.554683398676;5887.558433117619;5890.970545147246;5893.998020336639;5901.0558310670085;5913.881722365442;5527.530159936289;5610.943890561042;5707.743151558273;5837.211976383303;5849.064149736022;5843.152742852348;5909.734061967308;5915.378885217162;5938.8218353449465;5946.405359464192;5716.228309178207;5719.28508936383;5724.026915424472;5729.9713501432225;5747.195392645117 11:25:17 INFO - PROCESS | 24857 | |1;ext.html;596.6390333848021;615.1326629452471;626.8088233088909;643.6170478565252;655.7278729327329;34508.30983380331;37792.24415511688;45230.77384613077;45929.31106033404;46366.30450543245;48318.27522587164;48459.75770121144;48733.51266487334;48739.51260487394;48746.26880596785;9187.989321174682;9353.95323023384;9355.766105847375;9357.532123393838;9366.765830854249;8530.74407767765;8731.039585645574;10751.139908807316;11062.778744425106;11075;11213.66359009227;11285.774284514306;11293.378864162467;11308.547658093667;11325.377104259262;11062;11113.44432778366;11116.888831111706;11121.054710349548;11123.221374503788;10930.234883558154;10995.560177592886;10998.12015038803;10999.61501347449;11019.449027548591;45795.77102114502;46063.76968115138;46090;46128.53871461276;46215.07569848618;3752.343339915531;3762.5108735864437;3774.735768496206;3867.2265546890735;3919.2945269851416;31427.52858707121;34141.14647133841;34183;34461.827690861384;34640.653593464245;4686.554777296152;4720.244760838249;4785.784639691187;4814.759262036884;4878.658493905428;329425;329622;330458;333911;334651.99999999756;39518.40722389166;68501.31498685048;68888.31111688819;69098.65450672715;69233.30766692369;40374.59625403767;42372.15255694869;42377.57622423798;42378.364324535156;42385.78807105945;17352.566185845455;17523.47429577089;17539.123043847758;17539.473815785546;17541.386051488138;10821.83767243492;11071;13993.860061399255;14065.226412547408;14091.85908140926;9545.236381089497;9749.4759956084;9824.950875245579;9860.359076660137;9925.702228933143;3752.2870654575545;3800.961990380061;3826.827792749333;3834.386498160337;3849.576546579874;1019.2373601156381;1028.2956175020136;1087.1085709718113;1161.1059484197121;1185.1289302362757;33201.501977469874;34149.48775768365;34194.31611367759;34611.653883460844;34622.65377346244;1164.336328292865;1165.143619439711;1197.3235122155954;1239.6652903715947;1264.9620511384674;17288.877637633494;17976.754969859016;18107.909460452614;18158.182881770354;18219.45341639753;510130;511895;512831;513942;515067;61085;61420;61760;61778.69110654418;61859.69070154711;1262.9305388203736;1304.230504002643;1312.9080964332595;1425.5153247895557;1427.1223197733527;28930.710692893645;33487;34259.4861077089;36227;36488.087797804204;56971.71514142569;57772.42227577839;57799.711001444724;57802.421975781384;57861.71069144627;428502;430241;431687;432468;433478;28062.2984425391;28671;30534.541981869846;31222.843885780425;32310.515342270355;45611.31583026324;49702.25446618231;50201.49798501968;50206;51639;40993.06410838122;42523.50893987904;42902.78548607237;43352.56647433611;44222.77888610536;43288.567114328456;44102.55897440985;44229.77885110554;45035.32447013232;45071.32393014042;42808.57191428046;42941.570584295005;43040.56959430491;43050.78474607607;43171.35242971295;35446.645533545365;37105.814470928555;37484.81257593694;37929.43105853359;38185.80907095447;28104;28226.43547129087;28240.85879570589;28546.57180142341;28641.713582863904 11:25:17 INFO - PROCESS | 24857 | |2;jquery.html;420.3715445409114;422.5808913308913;431.30129190711045;434.33980349868193;442.7321470510339;18096.72854907176;18525.62948741026;19776.90111549444;19918.50203744907;20043.19827206912;18902.243910243607;19219.23123075079;19257.229710811585;19260.61478770424;19366.612667746638;5337.2527846101575;5650.886982260352;5685.061964775828;5741.425857414246;5773.740181691834;5642.7742890284335;5654.038813401731;5699.2306038684665;5700.116481945284;6183.690815459209;5946.43508866657;6099.756009759604;6112.816615501542;6113.266408031042;6115.877682446348;5609.158626206061;5653.434656534355;5729.026065568843;6096.207493025922;6183.412575805291;5513.972430137864;5517.420670829545;5519.337679478448;5520.751566179531;5520.889582208333;14877.776833347509;15214.771778423332;15237.314320855588;15297.388104475807;15306.234688265542;2468.2101727447225;2499.7250302466714;2569.56317426038;2908.200244932639;3004.804687695315;11232.49453774582;11460.426978651034;15013.624659383602;15095.773563396559;15702.293396797171;2001.2395289789931;2094.9266775662777;2105.1263725553877;2118.03629348646;2132.893355332227;57220.71389643025;65275.673621632064;72443;73463.26536734564;85055.5747221266;11663;11832.88167118335;11938.343391113573;11987.160898737178;12154.209976351509;17132.40036598713;17165.656686866194;17181.82818171802;17190.31238750461;17196.22616982239;8497.447665901696;8571.95714021426;8574.914250857537;8645.827083458296;8772.692955746646;8120.878186827203;8202.712905048294;8299.087100418948;8350.123237060021;8351;5056.570191533688;5196.9740151299;5220.817271395483;5246.213068039749;5281.524662780368;2083.9672191656978;2106.147010460766;2159;2170.0777169702815;2183.4213933307688;992.8411454167299;1004.7588578741049;1048.2871647279771;1085.8316960871077;1111.9444027798577;20045.699314510293;20225.696614550794;20515.58968820645;20725.58548829015;20974.895125524275;1023.2376879225025;1034.177828626244;1069.3049517813329;1116.9385683787307;1151.0848875144281;10490;11325.433728313552;11398.316101033965;11528.193026488234;11591.710207244887;480672;486748;489118;491411;494624;68356.6582167086;79740.20259797327;93977;95173.5241323789;96677;1019.3323373190572;1055.931364461292;1061.946902654864;1123.292325834719;1127.6053381316474;17883.463496095137;18056.90971545134;18486.445406637824;18523.259069637603;18618.627627447106;42538;42589;42688.573114269704;43273.3508997359;43948.780256098515;55578;58462.415375845696;58827.41172588219;59215;60227;8512.787180320542;8536.871946920677;8616.65533378683;8761.123887611187;8909.688160914337;11461.968422841985;11465.656030319104;12898.226106433644;13199.934000329937;13406.262655553648;10565.471726413802;10758.193135514712;10898.78202435931;11005.834912476479;11020.944895275472;10428.843567346345;10636.84044739345;10840.186985976241;11034.779304413707;11248.662540123809;10978.341299522055;11078.390688512209;11164.218504704917;11220;11288.153388495732;8957.328200384867;8982.191602755784;9025.593848276712;9054.185123338932;9269.67556135532;8715.869261960948;10545.367277963347;11121.443927803739;11335.149863760416;11366.090712743126 11:25:17 INFO - PROCESS | 24857 | |3;mootools.html;1541.9845801541987;1560.7190705672979;1746;1807.8824876383042;1868.4861663042652;9177.724668259954;9892.258080643944;9900.009999000096;9908.653197138092;9909.950450247748;8563.571821408936;8831.293496520278;8831.690890818823;9204.861927071099;9753.707388778348;2485.9751402486013;2525.5201511712717;2537.1120107962156;2539.0351666366846;2541.8220724549196;2435.9634605480933;2495.238952119603;2504.136073054802;2508.6989561252585;2510;2459.27451401836;2461.4215659320043;2483.8758062096913;2499.825012249143;2508.7867531259867;2433.2943446400523;2434.8782560871973;2441.56051910656;2511.6860392450944;2518.3074654469983;2435.7442468540903;2436.074291769134;2441.841280316774;2445.376429010591;2496.188738659943;9729.173020293283;9781.853272200922;9832.262580306506;9839.212862971017;9850;5522.5581953443625;5615.859603509904;5643.294588176478;5648.548116150698;5650.576206784466;3418.2138108234994;3528.982355088234;3538.9115272118147;3567.090391950062;3600.891973240807;1256.7245572232114;1325.5426877727168;1327.482281910056;1327.8472975607735;1336.6791969927244;13333.399997000159;13346.33268336589;13349.666258343523;13362;13368.197908125447;4829.782659780319;5218.608604354688;5223.764930578133;5235.685858848481;5247.2129180623215;11267.098632109411;11300.20898537111;11300.604478843201;11301.886981130083;11305.095592352593;5811.982902991959;5841.853953651193;5848.590598658053;5851.502622277154;5862.03276459388;4376.450058498079;5259.894802103937;5318.680879147263;5375.9462405376225;5529.529989950899;4481.551844815557;4487.461504619467;4490.348899409567;4497.235469970113;4568;1378.152436251718;1382.3710211853584;1388.7917511764626;1393.2476462710024;1400.2438683111209;985.6402413119304;986.6201512417771;995.2386424385351;1005.5424781724298;1018.3787889387615;6233.625982440977;6260.342664020212;6318.147050148263;6394.1687580614225;6529.314421985718;497.1796535716097;498.68831980012493;507.51785803486837;510.7982346972925;522.1723568144457;3962.0293028208275;4063.3092374295848;4135.937960930589;4172.7913604319665;4175.62419382257;12032.338221397733;12044.15690901646;12323.260604363766;12406.379681015913;12440.75118497643;12204.511819527119;12306.200096993667;12320;12324.137310388187;12328.445219965122;8980.775480612907;9007.504587247633;9035.096490350912;9110.863337050083;9150.679726209552;6322.146510221245;6404.359564043559;6407.679616019273;6447.580907241015;6556.114924485133;10782.568697252022;11208.383538905438;11245.493952771982;11284.815094414967;11433.656990290305;11341.546338146713;11554.653360399201;11561.768764624829;11591.76816463649;11654.883451165719;7918.604069796603;8165.1018387978465;8409.285210757154;8720.78198045054;8961.775955601162;9319.767005824908;9656.75858103553;9665.516724163905;9667.129958303787;9699.224062075158;8590.527520986405;8594.527300998256;8617.526036068077;8629.180227878342;8710.651573936972;8132.3494120471405;8249.628766705633;8259.967504061991;8335.624896879533;8521.957390213258;7030.648467576703;7199.316064973819;7234.276572342724;7436.144843343085;7443.627818609156;5226.660267082628;5374.865628359323;5397.487238712316;5505.752241149078;5714.685692286964;5332.893342133058;5379.757910893941;5518;5576.749046292845;5583.525400341016 11:25:17 INFO - PROCESS | 24857 | |4;prototype.html;354.8030842882201;359.38903863432165;367.6286950180318;372.1292176307438;375.71257987639444;5515.428102990649;5534.501894829465;5569.554435645149;5571.972140139299;5604.075327570956;5103.311053007852;5290.894182116355;5291.31212942317;5291.6031297652635;5440.972795136019;4208.494980602332;4287.1425714857;4361.411209486726;4386.736795792247;4410.228210063242;4348.456442944632;4362.214801335758;4366.868993930171;4379.58393952574;4394.274944634131;4071.1043570414463;4236;4236.555161708023;4278.828846846122;4323;4231.83072677091;4246.681498887596;4249.723767955088;4250.617444430016;4253.107886637085;3757.89142203048;3759.342115129841;3760.078780698719;3766.303233901737;3783.3946568549177;5241.842744717665;5313.256144139824;5322.467753224647;5387.703676297802;5401.972990135064;4901.779419926112;4901.852944411673;4912.754362281908;4918.458969513386;4926.142837154478;5709.628874123168;5716.485516303511;5744.770209191627;5754.165645981351;5775.537956963432;4036.374361973899;4158.625723684883;4164.12553363794;4165.416841642173;4231.87304380869;5865.472107510302;5903;5933.406659334032;5937.020391635375;5951.404859514014;4266.253405653998;4266.759951025736;4292.141571685675;4312.935305970413;4323.740575565476;4109.671226301889;4321.91952011997;4341.218580655449;4372.540883207217;4387.561243875587;4876.8295609053575;4888.3114287141925;4893.168161412568;4900.436449808318;4903.5586797188425;5690.374058853523;5744.827655170351;5746.195532625436;5779.566532510079;5814.505767009851;1450.3835869755312;1483.5845963130341;1485.4949317231976;1497.9026363286353;1516.696660667871;954.5990683912773;960.8078384323163;961.5144352102144;977.3305285879053;982.6904525074578;4924.285978533093;4977.751112444435;4982.676126051795;4990.675606085593;4996.300517927493;5102.520269121913;5149.845504634867;5159.684280508446;5166.664166829144;5181.8340873303205;4735.792372944877;4935.481774413706;4942.654014218971;4953.826616068421;4964.925526117111;2739.233014755832;2741.930647047653;2747.6290700755544;2750.22993561803;2752.4357506711076;5210.635255532076;5236.24074509194;5236.607254455931;5278.419373868871;5326.334208223972;4893.510648935078;5159.2003239497935;5189.89809127304;5217.869553261199;5232.581393488512;5250.553702935294;5251.947480525146;5273.815416460406;5287.867803304871;5326.280952071498;5140.76866541014;5205.375354957429;5234.7906083756225;5236;5287.312649355559;4752.572268495852;5025.853670721743;5063.822766203165;5096.949030509648;5103.7192954387865;5175.645081487989;5205.189197833279;5227.065985585357;5264.9736751315995;5269.4730526947;3795.8291876865055;3803.106270026597;3805.3340665384003;3820.8280627371278;4015.13674559971;5290.153575427913;5677.233573467694;5751.568632352507;5885.411458854252;5894.6757928314355;5732.226149469769;5745.971270143623;5750.539956803529;5759.625624334572;5773.942260577341;5484.351118348108;5759.827205183851;5795.275590551181;5807.332156801853;5820.854478638068;5742.885142297214;5746.5402767779315;5751.597388182954;5765.4811067004175;5774.335951365647;5685.516731077904;5799.507041901317;5819.447152520504;5827.970860145672;5871.383504732113;5644.81458893637;5694.914576281276;5700.287464066992;5702.40124786908;5705.771769129188 11:25:17 INFO - PROCESS | 24857 | |5;yui.html;820.7032888036903;820.8194197276597;849.745076477057;870.1689886158717;888.6134531478812;16283.104429256386;17825.28698852046;17848.37530686426;17911.462656120304;17911.910440447813;14955.700885982274;15057.774133388008;15061.096334219954;15091.09453432792;15102.697946041073;705.28413660135;722.4689852958098;842.2335674536173;861.543382007537;868.2316150207049;853.8206976534935;856.8029353248756;856.8629019356904;857.2413414128509;857.5626430520448;897.4480694372979;897.8922529296461;906.9909300906972;908.6592527802075;909.0182602789005;897.5601955042015;901.3645380007111;903.3315346643502;903.5843511984496;903.8915330160357;667.0561155964305;668.4719071933167;668.8762578922915;669.2571245917028;669.6183175589915;14622.341994610268;14743.26283685822;14747.410103595843;14768.187749673763;14773.187474688888;13463.259520726357;13810.723785524333;13842;14124.081934674214;16264.593385165466;13723.45106195751;13849.861501384958;13886.305684715824;14045.43818247269;14282;4673.789679464398;4727.479977202505;4756.548127927841;4764.309175169616;4791.161546729343;82067;83473;84178.57910710407;84645;84958.57520712419;11468.713282168013;11662;11693.064554835593;11767.764644707058;11898.881011189951;19312.8068719311;19426.22295108208;19431.125599348063;19475.513112172026;21140.577188456144;8859.11408859109;9087.591058402388;9189.954050229706;9267.72196834096;9324.25405967521;4516.480604730433;4873.31773551703;4874.731889746098;5022.648414610942;5263.526282634582;3763.5483741950593;3894.668953139015;3903.7072219583647;3931.722190288168;3931.901702457404;663.0882536512296;675.061664286642;676.5027704637088;694.1808665774333;701.4038067642463;709.4076446167508;720.2833180984953;768.108993567459;769.7806125254276;802.101646156297;9640.276979226446;9874.555644995993;9990.700278991642;10208.846867296996;10211;636.3382082634101;660.41883142834;736.5249414127858;764.5221736414741;775.6238224461132;4868.367112275381;5046.646734728607;5108.310378098983;5110.66780659256;5191.662541934762;70059.64970175117;80590.3586748922;114357;122056;140333;80400;112032;117715.41142294405;118907.40546297214;121821;100609.49695251478;101037;101126.49436752769;103944.48027759812;104000.47999759953;9506.382085164441;9682.322237443594;9772.511374431107;9857.11285984265;9884.505774711091;56667;56766.14850777324;57686.13470797858;57856;58909.705451472466;50861.491385085676;52079.479205208976;60930;69717.16555589491;78651.60674196592;13603.523876664269;13903.930480347533;13958.23229722375;14110.858891410955;14192.574222773334;15178;15389.613310476027;15624.687506249584;16149.67700646004;16976;14183;14518.419263229775;14617.19605421712;14735.189564574051;14755.188464634548;13822.447102116204;14110.78833817473;14150.78773818414;14201.431942722176;14416.639584010065;14489.492867749577;14642.487512936996;14916.25418729081;15228.77156842626;15300.736213362738;11468.900310172849;11737.119716021503;12061.276323420623;12077.939610301892;12146.574869879865;11970.820437693616;12025.218360806519;12040.157188996685;12052.939735301617;12365.443555040225 11:25:17 INFO - PROCESS | 24857 | __end_tp_report 11:25:17 INFO - PROCESS | 24857 | __start_cc_report 11:25:17 INFO - PROCESS | 24857 | _x_x_mozilla_cycle_collect,838 11:25:17 INFO - PROCESS | 24857 | __end_cc_report 11:25:17 INFO - PROCESS | 24857 | __startTimestamp1484249117873__endTimestamp 11:25:17 INFO - PROCESS | 24857 | 11:25:17 INFO - PROCESS | 24857 | ------- Summary: start ------- 11:25:17 INFO - PROCESS | 24857 | Number of tests: 6 11:25:17 INFO - PROCESS | 24857 | 11:25:17 INFO - PROCESS | 24857 | [#0] dojo.html Cycles:165 Average:5504.03 Median:5725.37 stddev:635.82 (11.1%) stddev-sans-first:608.02 11:25:17 INFO - PROCESS | 24857 | Values: 3053.8 3088.2 3090.0 3101.8 3122.9 5398.4 5470.4 5481.5 5488.8 5495.2 5544.0 5587.6 5608.3 5609.4 5644.1 5051.3 5078.5 5118.8 5131.8 5170.3 5017.5 5147.6 5164.6 5172.3 5174.7 5001.3 5023.2 5043.2 5044.6 5072.9 5088.3 5116.8 5121.1 5172.7 5178.3 5006.6 5071.1 5128.5 5144.3 5169.3 5238.9 5290.8 5438.3 5472.2 5514.2 5858.4 5882.2 5884.9 5965.8 5973.5 6010.5 6014.7 6016.8 6018.9 6024.2 5379.5 5403.1 5415.5 5420.4 5471.1 5958.2 5983.1 5991.4 5995.4 5995.8 5737.9 5759.7 5764.2 5770.2 5775.7 5693.3 5742.8 5790.5 5826.6 5841.2 5842.9 5849.1 5849.4 5858.7 5881.7 5814.9 5866.5 5876.2 5881.3 5889.4 4377.3 4407.5 4461.0 4502.8 4551.5 3958.1 4003.1 4011.7 4023.0 4047.7 5558.7 5560.8 5563.5 5567.7 5573.1 5725.4 5805.8 5806.4 5891.4 5893.9 5615.6 5667.0 5670.2 5700.0 5706.3 5223.8 5226.5 5233.7 5235.6 5244.5 5955.9 6130.0 6177.7 6179.0 6201.6 5858.0 5925.4 5929.8 5988.4 6035.8 6166.2 6166.9 6172.6 6175.2 6186.5 5921.3 5922.9 5924.7 5940.2 5972.9 5726.3 5801.2 5907.5 5938.4 5990.3 5852.3 5909.0 5909.6 5913.7 5937.6 5887.6 5891.0 5894.0 5901.1 5913.9 5527.5 5610.9 5707.7 5837.2 5849.1 5843.2 5909.7 5915.4 5938.8 5946.4 5716.2 5719.3 5724.0 5730.0 5747.2 11:25:17 INFO - PROCESS | 24857 | 11:25:17 INFO - PROCESS | 24857 | [#1] ext.html Cycles:180 Average:59476.59 Median:3830.61 stddev:114213.25 (2981.6%) stddev-sans-first:114448.09 11:25:17 INFO - PROCESS | 24857 | Values: 596.6 615.1 626.8 643.6 655.7 34508.3 37792.2 45230.8 45929.3 46366.3 48318.3 48459.8 48733.5 48739.5 48746.3 9188.0 9354.0 9355.8 9357.5 9366.8 8530.7 8731.0 10751.1 11062.8 11075.0 11213.7 11285.8 11293.4 11308.5 11325.4 11062.0 11113.4 11116.9 11121.1 11123.2 10930.2 10995.6 10998.1 10999.6 11019.4 45795.8 46063.8 46090.0 46128.5 46215.1 3752.3 3762.5 3774.7 3867.2 3919.3 31427.5 34141.1 34183.0 34461.8 34640.7 4686.6 4720.2 4785.8 4814.8 4878.7 329425.0 329622.0 330458.0 333911.0 334652.0 39518.4 68501.3 68888.3 69098.7 69233.3 40374.6 42372.2 42377.6 42378.4 42385.8 17352.6 17523.5 17539.1 17539.5 17541.4 10821.8 11071.0 13993.9 14065.2 14091.9 9545.2 9749.5 9825.0 9860.4 9925.7 3752.3 3801.0 3826.8 3834.4 3849.6 1019.2 1028.3 1087.1 1161.1 1185.1 33201.5 34149.5 34194.3 34611.7 34622.7 1164.3 1165.1 1197.3 1239.7 1265.0 17288.9 17976.8 18107.9 18158.2 18219.5 510130.0 511895.0 512831.0 513942.0 515067.0 61085.0 61420.0 61760.0 61778.7 61859.7 1262.9 1304.2 1312.9 1425.5 1427.1 28930.7 33487.0 34259.5 36227.0 36488.1 56971.7 57772.4 57799.7 57802.4 57861.7 428502.0 430241.0 431687.0 432468.0 433478.0 28062.3 28671.0 30534.5 31222.8 32310.5 45611.3 49702.3 50201.5 50206.0 51639.0 40993.1 42523.5 42902.8 43352.6 44222.8 43288.6 44102.6 44229.8 45035.3 45071.3 42808.6 42941.6 43040.6 43050.8 43171.4 35446.6 37105.8 37484.8 37929.4 38185.8 28104.0 28226.4 28240.9 28546.6 28641.7 11:25:17 INFO - PROCESS | 24857 | 11:25:17 INFO - PROCESS | 24857 | [#2] jquery.html Cycles:180 Average:28587.45 Median:2164.54 stddev:80306.76 (3710.1%) stddev-sans-first:80504.19 11:25:17 INFO - PROCESS | 24857 | Values: 420.4 422.6 431.3 434.3 442.7 18096.7 18525.6 19776.9 19918.5 20043.2 18902.2 19219.2 19257.2 19260.6 19366.6 5337.3 5650.9 5685.1 5741.4 5773.7 5642.8 5654.0 5699.2 5700.1 6183.7 5946.4 6099.8 6112.8 6113.3 6115.9 5609.2 5653.4 5729.0 6096.2 6183.4 5514.0 5517.4 5519.3 5520.8 5520.9 14877.8 15214.8 15237.3 15297.4 15306.2 2468.2 2499.7 2569.6 2908.2 3004.8 11232.5 11460.4 15013.6 15095.8 15702.3 2001.2 2094.9 2105.1 2118.0 2132.9 57220.7 65275.7 72443.0 73463.3 85055.6 11663.0 11832.9 11938.3 11987.2 12154.2 17132.4 17165.7 17181.8 17190.3 17196.2 8497.4 8572.0 8574.9 8645.8 8772.7 8120.9 8202.7 8299.1 8350.1 8351.0 5056.6 5197.0 5220.8 5246.2 5281.5 2084.0 2106.1 2159.0 2170.1 2183.4 992.8 1004.8 1048.3 1085.8 1111.9 20045.7 20225.7 20515.6 20725.6 20974.9 1023.2 1034.2 1069.3 1116.9 1151.1 10490.0 11325.4 11398.3 11528.2 11591.7 480672.0 486748.0 489118.0 491411.0 494624.0 68356.7 79740.2 93977.0 95173.5 96677.0 1019.3 1055.9 1061.9 1123.3 1127.6 17883.5 18056.9 18486.4 18523.3 18618.6 42538.0 42589.0 42688.6 43273.4 43948.8 55578.0 58462.4 58827.4 59215.0 60227.0 8512.8 8536.9 8616.7 8761.1 8909.7 11462.0 11465.7 12898.2 13199.9 13406.3 10565.5 10758.2 10898.8 11005.8 11020.9 10428.8 10636.8 10840.2 11034.8 11248.7 10978.3 11078.4 11164.2 11220.0 11288.2 8957.3 8982.2 9025.6 9054.2 9269.7 8715.9 10545.4 11121.4 11335.1 11366.1 11:25:17 INFO - PROCESS | 24857 | 11:25:17 INFO - PROCESS | 24857 | [#3] mootools.html Cycles:180 Average:6326.84 Median:503.10 stddev:3693.54 (734.2%) stddev-sans-first:3686.40 11:25:17 INFO - PROCESS | 24857 | Values: 1542.0 1560.7 1746.0 1807.9 1868.5 9177.7 9892.3 9900.0 9908.7 9910.0 8563.6 8831.3 8831.7 9204.9 9753.7 2486.0 2525.5 2537.1 2539.0 2541.8 2436.0 2495.2 2504.1 2508.7 2510.0 2459.3 2461.4 2483.9 2499.8 2508.8 2433.3 2434.9 2441.6 2511.7 2518.3 2435.7 2436.1 2441.8 2445.4 2496.2 9729.2 9781.9 9832.3 9839.2 9850.0 5522.6 5615.9 5643.3 5648.5 5650.6 3418.2 3529.0 3538.9 3567.1 3600.9 1256.7 1325.5 1327.5 1327.8 1336.7 13333.4 13346.3 13349.7 13362.0 13368.2 4829.8 5218.6 5223.8 5235.7 5247.2 11267.1 11300.2 11300.6 11301.9 11305.1 5812.0 5841.9 5848.6 5851.5 5862.0 4376.5 5259.9 5318.7 5375.9 5529.5 4481.6 4487.5 4490.3 4497.2 4568.0 1378.2 1382.4 1388.8 1393.2 1400.2 985.6 986.6 995.2 1005.5 1018.4 6233.6 6260.3 6318.1 6394.2 6529.3 497.2 498.7 507.5 510.8 522.2 3962.0 4063.3 4135.9 4172.8 4175.6 12032.3 12044.2 12323.3 12406.4 12440.8 12204.5 12306.2 12320.0 12324.1 12328.4 8980.8 9007.5 9035.1 9110.9 9150.7 6322.1 6404.4 6407.7 6447.6 6556.1 10782.6 11208.4 11245.5 11284.8 11433.7 11341.5 11554.7 11561.8 11591.8 11654.9 7918.6 8165.1 8409.3 8720.8 8961.8 9319.8 9656.8 9665.5 9667.1 9699.2 8590.5 8594.5 8617.5 8629.2 8710.7 8132.3 8249.6 8260.0 8335.6 8522.0 7030.6 7199.3 7234.3 7436.1 7443.6 5226.7 5374.9 5397.5 5505.8 5714.7 5332.9 5379.8 5518.0 5576.7 5583.5 11:25:17 INFO - PROCESS | 24857 | 11:25:17 INFO - PROCESS | 24857 | [#4] prototype.html Cycles:180 Average:4641.62 Median:5159.44 stddev:1330.03 (25.8%) stddev-sans-first:1294.26 11:25:17 INFO - PROCESS | 24857 | Values: 354.8 359.4 367.6 372.1 375.7 5515.4 5534.5 5569.6 5572.0 5604.1 5103.3 5290.9 5291.3 5291.6 5441.0 4208.5 4287.1 4361.4 4386.7 4410.2 4348.5 4362.2 4366.9 4379.6 4394.3 4071.1 4236.0 4236.6 4278.8 4323.0 4231.8 4246.7 4249.7 4250.6 4253.1 3757.9 3759.3 3760.1 3766.3 3783.4 5241.8 5313.3 5322.5 5387.7 5402.0 4901.8 4901.9 4912.8 4918.5 4926.1 5709.6 5716.5 5744.8 5754.2 5775.5 4036.4 4158.6 4164.1 4165.4 4231.9 5865.5 5903.0 5933.4 5937.0 5951.4 4266.3 4266.8 4292.1 4312.9 4323.7 4109.7 4321.9 4341.2 4372.5 4387.6 4876.8 4888.3 4893.2 4900.4 4903.6 5690.4 5744.8 5746.2 5779.6 5814.5 1450.4 1483.6 1485.5 1497.9 1516.7 954.6 960.8 961.5 977.3 982.7 4924.3 4977.8 4982.7 4990.7 4996.3 5102.5 5149.8 5159.7 5166.7 5181.8 4735.8 4935.5 4942.7 4953.8 4964.9 2739.2 2741.9 2747.6 2750.2 2752.4 5210.6 5236.2 5236.6 5278.4 5326.3 4893.5 5159.2 5189.9 5217.9 5232.6 5250.6 5251.9 5273.8 5287.9 5326.3 5140.8 5205.4 5234.8 5236.0 5287.3 4752.6 5025.9 5063.8 5096.9 5103.7 5175.6 5205.2 5227.1 5265.0 5269.5 3795.8 3803.1 3805.3 3820.8 4015.1 5290.2 5677.2 5751.6 5885.4 5894.7 5732.2 5746.0 5750.5 5759.6 5773.9 5484.4 5759.8 5795.3 5807.3 5820.9 5742.9 5746.5 5751.6 5765.5 5774.3 5685.5 5799.5 5819.4 5828.0 5871.4 5644.8 5694.9 5700.3 5702.4 5705.8 11:25:17 INFO - PROCESS | 24857 | 11:25:17 INFO - PROCESS | 24857 | [#5] yui.html Cycles:180 Average:21688.12 Median:4700.63 stddev:31476.50 (669.6%) stddev-sans-first:31525.80 11:25:17 INFO - PROCESS | 24857 | Values: 820.7 820.8 849.7 870.2 888.6 16283.1 17825.3 17848.4 17911.5 17911.9 14955.7 15057.8 15061.1 15091.1 15102.7 705.3 722.5 842.2 861.5 868.2 853.8 856.8 856.9 857.2 857.6 897.4 897.9 907.0 908.7 909.0 897.6 901.4 903.3 903.6 903.9 667.1 668.5 668.9 669.3 669.6 14622.3 14743.3 14747.4 14768.2 14773.2 13463.3 13810.7 13842.0 14124.1 16264.6 13723.5 13849.9 13886.3 14045.4 14282.0 4673.8 4727.5 4756.5 4764.3 4791.2 82067.0 83473.0 84178.6 84645.0 84958.6 11468.7 11662.0 11693.1 11767.8 11898.9 19312.8 19426.2 19431.1 19475.5 21140.6 8859.1 9087.6 9190.0 9267.7 9324.3 4516.5 4873.3 4874.7 5022.6 5263.5 3763.5 3894.7 3903.7 3931.7 3931.9 663.1 675.1 676.5 694.2 701.4 709.4 720.3 768.1 769.8 802.1 9640.3 9874.6 9990.7 10208.8 10211.0 636.3 660.4 736.5 764.5 775.6 4868.4 5046.6 5108.3 5110.7 5191.7 70059.6 80590.4 114357.0 122056.0 140333.0 80400.0 112032.0 117715.4 118907.4 121821.0 100609.5 101037.0 101126.5 103944.5 104000.5 9506.4 9682.3 9772.5 9857.1 9884.5 56667.0 56766.1 57686.1 57856.0 58909.7 50861.5 52079.5 60930.0 69717.2 78651.6 13603.5 13903.9 13958.2 14110.9 14192.6 15178.0 15389.6 15624.7 16149.7 16976.0 14183.0 14518.4 14617.2 14735.2 14755.2 13822.4 14110.8 14150.8 14201.4 14416.6 14489.5 14642.5 14916.3 15228.8 15300.7 11468.9 11737.1 12061.3 12077.9 12146.6 11970.8 12025.2 12040.2 12052.9 12365.4 11:25:17 INFO - PROCESS | 24857 | -------- Summary: end -------- 11:25:17 INFO - PROCESS | 24857 | 11:25:18 INFO - TEST-INFO | 24857: exit 0 11:25:18 INFO - TEST-OK | dromaeo_css | took 1113593ms 11:25:18 INFO - TEST-START | kraken 11:25:18 INFO - operating with platform_type : linux_ 11:25:18 INFO - Initialising browser for kraken test... 11:25:18 INFO - TEST-INFO | started process 25168 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPGLJrP/profile http://localhost:51774/getInfo.html) 11:25:22 INFO - PROCESS | 25168 | __metrics Screen width/height:1600/1200 11:25:22 INFO - PROCESS | 25168 | colorDepth:24 11:25:22 INFO - PROCESS | 25168 | Browser inner width/height: 1024/697 11:25:22 INFO - PROCESS | 25168 | __metrics 11:25:23 INFO - PROCESS | 25168 | 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" 11:25:23 INFO - PROCESS | 25168 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:25:23 INFO - PROCESS | 25168 | console.error: PushService: 11:25:23 INFO - PROCESS | 25168 | stateChangeProcessEnqueue: Error transitioning state 11:25:23 INFO - PROCESS | 25168 | UnknownError 11:25:24 INFO - TEST-INFO | 25168: exit 0 11:25:24 INFO - Browser initialized. 11:25:24 INFO - Running cycle 1/1 for kraken test... 11:25:24 INFO - TEST-INFO | started process 25260 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPGLJrP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:36 INFO - PROCESS | 25260 | RSS: Main: 143818752 11:25:36 INFO - PROCESS | 25260 | 11:25:38 INFO - PROCESS | 25260 | Cycle 1(1): loaded http://localhost:51774/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51774/tests/kraken/driver.html?testName=audio-beat-detection) 11:25:39 INFO - PROCESS | 25260 | RSS: Main: 187191296 11:25:39 INFO - PROCESS | 25260 | 11:25:42 INFO - PROCESS | 25260 | Cycle 1(1): loaded http://localhost:51774/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51774/tests/kraken/driver.html?testName=audio-dft) 11:25:42 INFO - PROCESS | 25260 | RSS: Main: 174477312 11:25:42 INFO - PROCESS | 25260 | 11:25:45 INFO - PROCESS | 25260 | Cycle 1(1): loaded http://localhost:51774/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51774/tests/kraken/driver.html?testName=audio-fft) 11:25:46 INFO - PROCESS | 25260 | RSS: Main: 264998912 11:25:46 INFO - PROCESS | 25260 | 11:25:48 INFO - PROCESS | 25260 | Cycle 1(1): loaded http://localhost:51774/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51774/tests/kraken/driver.html?testName=audio-oscillator) 11:25:48 INFO - PROCESS | 25260 | RSS: Main: 171728896 11:25:48 INFO - PROCESS | 25260 | 11:25:50 INFO - PROCESS | 25260 | Cycle 1(1): loaded http://localhost:51774/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51774/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:25:51 INFO - PROCESS | 25260 | RSS: Main: 173674496 11:25:51 INFO - PROCESS | 25260 | 11:25:54 INFO - PROCESS | 25260 | Cycle 1(1): loaded http://localhost:51774/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51774/tests/kraken/driver.html?testName=imaging-darkroom) 11:25:55 INFO - PROCESS | 25260 | RSS: Main: 209772544 11:25:55 INFO - PROCESS | 25260 | 11:25:58 INFO - PROCESS | 25260 | Cycle 1(1): loaded http://localhost:51774/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51774/tests/kraken/driver.html?testName=imaging-desaturate) 11:25:58 INFO - PROCESS | 25260 | RSS: Main: 208183296 11:25:58 INFO - PROCESS | 25260 | 11:26:01 INFO - PROCESS | 25260 | Cycle 1(1): loaded http://localhost:51774/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51774/tests/kraken/driver.html?testName=json-parse-financial) 11:26:02 INFO - PROCESS | 25260 | RSS: Main: 208904192 11:26:02 INFO - PROCESS | 25260 | 11:26:03 INFO - PROCESS | 25260 | Cycle 1(1): loaded http://localhost:51774/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51774/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:26:04 INFO - PROCESS | 25260 | RSS: Main: 170242048 11:26:04 INFO - PROCESS | 25260 | 11:26:06 INFO - PROCESS | 25260 | Cycle 1(1): loaded http://localhost:51774/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51774/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:26:06 INFO - PROCESS | 25260 | RSS: Main: 177209344 11:26:06 INFO - PROCESS | 25260 | 11:26:08 INFO - PROCESS | 25260 | Cycle 1(1): loaded http://localhost:51774/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51774/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:26:09 INFO - PROCESS | 25260 | RSS: Main: 187363328 11:26:09 INFO - PROCESS | 25260 | 11:26:11 INFO - PROCESS | 25260 | Cycle 1(1): loaded http://localhost:51774/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51774/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:26:12 INFO - PROCESS | 25260 | RSS: Main: 196042752 11:26:12 INFO - PROCESS | 25260 | 11:26:15 INFO - PROCESS | 25260 | Cycle 1(1): loaded http://localhost:51774/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51774/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:26:15 INFO - PROCESS | 25260 | RSS: Main: 192102400 11:26:15 INFO - PROCESS | 25260 | 11:26:17 INFO - PROCESS | 25260 | Cycle 1(1): loaded http://localhost:51774/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51774/tests/kraken/driver.html?testName=ai-astar) 11:26:17 INFO - PROCESS | 25260 | RSS: Main: 243924992 11:26:17 INFO - PROCESS | 25260 | 11:26:17 INFO - PROCESS | 25260 | __start_tp_report 11:26:17 INFO - PROCESS | 25260 | _x_x_mozilla_page_load 11:26:17 INFO - PROCESS | 25260 | _x_x_mozilla_page_load_details 11:26:17 INFO - PROCESS | 25260 | |i|pagename|runs| 11:26:17 INFO - PROCESS | 25260 | |0;ai-astar;111;111;110;110;111;109;109;110;109;109 11:26:17 INFO - PROCESS | 25260 | |1;audio-beat-detection;141;116;115;157;117;117;116;119;149;116 11:26:17 INFO - PROCESS | 25260 | |2;audio-dft;164;163;162;160;160;160;159;160;160;161 11:26:17 INFO - PROCESS | 25260 | |3;audio-fft;75;75;74;111;77;77;75;75;95;74 11:26:17 INFO - PROCESS | 25260 | |4;audio-oscillator;82;82;125;82;82;81;98;80;80;110 11:26:17 INFO - PROCESS | 25260 | |5;imaging-gaussian-blur;118;117;117;117;116;117;117;117;117;117 11:26:17 INFO - PROCESS | 25260 | |6;imaging-darkroom;147;146;146;146;146;146;146;146;147;146 11:26:17 INFO - PROCESS | 25260 | |7;imaging-desaturate;95;96;95;95;95;95;96;95;95;95 11:26:17 INFO - PROCESS | 25260 | |8;json-parse-financial;50;51;52;50;50;49;55;51;50;51 11:26:17 INFO - PROCESS | 25260 | |9;json-stringify-tinderbox;56;57;56;58;57;57;58;57;57;57 11:26:17 INFO - PROCESS | 25260 | |10;stanford-crypto-aes;79;73;73;73;75;83;75;74;73;82 11:26:17 INFO - PROCESS | 25260 | |11;stanford-crypto-ccm;131;129;125;130;127;124;119;122;172;127 11:26:17 INFO - PROCESS | 25260 | |12;stanford-crypto-pbkdf2;154;162;156;158;155;153;157;153;155;162 11:26:17 INFO - PROCESS | 25260 | |13;stanford-crypto-sha256-iterative;63;62;62;62;62;63;76;62;63;62 11:26:17 INFO - PROCESS | 25260 | __end_tp_report 11:26:17 INFO - PROCESS | 25260 | __start_cc_report 11:26:17 INFO - PROCESS | 25260 | _x_x_mozilla_cycle_collect,1618 11:26:17 INFO - PROCESS | 25260 | __end_cc_report 11:26:17 INFO - PROCESS | 25260 | __startTimestamp1484249177641__endTimestamp 11:26:17 INFO - PROCESS | 25260 | 11:26:17 INFO - PROCESS | 25260 | ------- Summary: start ------- 11:26:17 INFO - PROCESS | 25260 | Number of tests: 14 11:26:17 INFO - PROCESS | 25260 | 11:26:17 INFO - PROCESS | 25260 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.00 stddev:0.88 (0.8%) stddev-sans-first:0.83 11:26:17 INFO - PROCESS | 25260 | Values: 111.0 111.0 110.0 110.0 111.0 109.0 109.0 110.0 109.0 109.0 11:26:17 INFO - PROCESS | 25260 | 11:26:17 INFO - PROCESS | 25260 | [#1] audio-beat-detection Cycles:10 Average:126.30 Median:118.00 stddev:16.15 (13.7%) stddev-sans-first:16.22 11:26:17 INFO - PROCESS | 25260 | Values: 141.0 116.0 115.0 157.0 117.0 117.0 116.0 119.0 149.0 116.0 11:26:17 INFO - PROCESS | 25260 | 11:26:17 INFO - PROCESS | 25260 | [#2] audio-dft Cycles:10 Average:160.90 Median:160.50 stddev:1.60 (1.0%) stddev-sans-first:1.24 11:26:17 INFO - PROCESS | 25260 | Values: 164.0 163.0 162.0 160.0 160.0 160.0 159.0 160.0 160.0 161.0 11:26:17 INFO - PROCESS | 25260 | 11:26:17 INFO - PROCESS | 25260 | [#3] audio-fft Cycles:10 Average:80.80 Median:75.00 stddev:12.34 (16.4%) stddev-sans-first:12.90 11:26:17 INFO - PROCESS | 25260 | Values: 75.0 75.0 74.0 111.0 77.0 77.0 75.0 75.0 95.0 74.0 11:26:17 INFO - PROCESS | 25260 | 11:26:17 INFO - PROCESS | 25260 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:82.00 stddev:15.73 (19.2%) stddev-sans-first:16.40 11:26:17 INFO - PROCESS | 25260 | Values: 82.0 82.0 125.0 82.0 82.0 81.0 98.0 80.0 80.0 110.0 11:26:17 INFO - PROCESS | 25260 | 11:26:17 INFO - PROCESS | 25260 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 11:26:17 INFO - PROCESS | 25260 | Values: 118.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 11:26:17 INFO - PROCESS | 25260 | 11:26:17 INFO - PROCESS | 25260 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 11:26:17 INFO - PROCESS | 25260 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 11:26:17 INFO - PROCESS | 25260 | 11:26:17 INFO - PROCESS | 25260 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:26:17 INFO - PROCESS | 25260 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 11:26:17 INFO - PROCESS | 25260 | 11:26:17 INFO - PROCESS | 25260 | [#8] json-parse-financial Cycles:10 Average:50.90 Median:51.00 stddev:1.66 (3.3%) stddev-sans-first:1.73 11:26:17 INFO - PROCESS | 25260 | Values: 50.0 51.0 52.0 50.0 50.0 49.0 55.0 51.0 50.0 51.0 11:26:17 INFO - PROCESS | 25260 | 11:26:17 INFO - PROCESS | 25260 | [#9] json-stringify-tinderbox Cycles:10 Average:57.00 Median:57.00 stddev:0.67 (1.2%) stddev-sans-first:0.60 11:26:17 INFO - PROCESS | 25260 | Values: 56.0 57.0 56.0 58.0 57.0 57.0 58.0 57.0 57.0 57.0 11:26:17 INFO - PROCESS | 25260 | 11:26:17 INFO - PROCESS | 25260 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:75.00 stddev:3.89 (5.2%) stddev-sans-first:3.97 11:26:17 INFO - PROCESS | 25260 | Values: 79.0 73.0 73.0 73.0 75.0 83.0 75.0 74.0 73.0 82.0 11:26:17 INFO - PROCESS | 25260 | 11:26:17 INFO - PROCESS | 25260 | [#11] stanford-crypto-ccm Cycles:10 Average:130.60 Median:128.00 stddev:15.01 (11.7%) stddev-sans-first:15.91 11:26:17 INFO - PROCESS | 25260 | Values: 131.0 129.0 125.0 130.0 127.0 124.0 119.0 122.0 172.0 127.0 11:26:17 INFO - PROCESS | 25260 | 11:26:17 INFO - PROCESS | 25260 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.50 Median:156.50 stddev:3.31 (2.1%) stddev-sans-first:3.38 11:26:17 INFO - PROCESS | 25260 | Values: 154.0 162.0 156.0 158.0 155.0 153.0 157.0 153.0 155.0 162.0 11:26:17 INFO - PROCESS | 25260 | 11:26:17 INFO - PROCESS | 25260 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:62.50 stddev:4.35 (7.0%) stddev-sans-first:4.60 11:26:17 INFO - PROCESS | 25260 | Values: 63.0 62.0 62.0 62.0 62.0 63.0 76.0 62.0 63.0 62.0 11:26:17 INFO - PROCESS | 25260 | -------- Summary: end -------- 11:26:17 INFO - PROCESS | 25260 | 11:26:18 INFO - TEST-INFO | 25260: exit 0 11:26:18 INFO - TEST-OK | kraken | took 60008ms 11:26:18 INFO - SUITE-END | took 1173s 11:26:18 INFO - Completed test suite (00:19:33) 11:26:18 INFO - javascript benchmark 11:26:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3053.8167709937406, 3088.2125058110187, 3090.042086953045, 3101.7673674474404, 3122.8750849966004, 5398.3521977362725, 5470.398256191816, 5481.506664400204, 5488.780448782049, 5495.20319553665, 5544.029794785916, 5587.580931430149, 5608.317504748579, 5609.439056094388, 5644.125160600103, 5051.343325367706, 5078.542931136197, 5118.795248190087, 5131.769070391822, 5170.327857378555, 5017.473165317644, 5147.639665223436, 5164.561012313958, 5172.250023746555, 5174.663646862942, 5001.299818025479, 5023.196288593826, 5043.218301163307, 5044.596432285409, 5072.9492705073035, 5088.313077734514, 5116.820911268125, 5121.052605268, 5172.672147687887, 5178.300929374562, 5006.5744411725045, 5071.087204303224, 5128.461511541309, 5144.3312369392115, 5169.276301317818, 5238.92141617876, 5290.788368465257, 5438.320209973754, 5472.151816468414, 5514.228008078872, 5858.443447872445, 5882.176495290662, 5884.882302353972, 5965.821025369246, 5973.492253158487, 6010.519158467312, 6014.729337179838, 6016.789412370546, 6018.939810601882, 6024.21685180928, 5379.542738867201, 5403.135498320289, 5415.458454154632, 5420.430854760272, 5471.124620060811, 5958.165856780054, 5983.132445795335, 5991.400859913973, 5995.370486098984, 5995.790147344822, 5737.8565535861935, 5759.683217423082, 5764.221830052889, 5770.2498675171955, 5775.711214439261, 5693.28833895763, 5742.7702891883855, 5790.478856902899, 5826.563007774349, 5841.211436456024, 5842.912356314659, 5849.093390524476, 5849.356570777211, 5858.736356863951, 5881.705914704247, 5814.941850581525, 5866.472017518444, 5876.236089308362, 5881.2942446906645, 5889.411058894077, 4377.3433984901885, 4407.537208593051, 4461.018575913294, 4502.752348620857, 4551.499335073206, 3958.1094253793244, 4003.1193137510286, 4011.7392369495888, 4022.959770402317, 4047.7166598337835, 5558.694271815089, 5560.805371811967, 5563.527100196528, 5567.693776842312, 5573.080441727069, 5725.370209276976, 5805.796797112081, 5806.419358064244, 5891.440313170242, 5893.852653683693, 5615.578831587565, 5667.036603777367, 5670.177824215466, 5699.971500142473, 5706.28671416073, 5223.843284701465, 5226.451222621646, 5233.738313084331, 5235.607329450307, 5244.475552444801, 5955.851103722268, 6130.049842274455, 6177.660228687465, 6178.99999999991, 6201.56589038772, 5858.0, 5925.377835327401, 5929.822105336847, 5988.431099045583, 6035.78874739382, 6166.229221347332, 6166.907496387647, 6172.598781079216, 6175.166352542349, 6186.505079593531, 5921.289445266596, 5922.911156332572, 5924.674142922181, 5940.198073260228, 5972.8805423892145, 5726.341470730919, 5801.158831969256, 5907.49786268172, 5938.406159384027, 5990.31111422192, 5852.3269823969085, 5909.0, 5909.556783241188, 5913.674747888907, 5937.554683398676, 5887.558433117619, 5890.970545147246, 5893.998020336639, 5901.0558310670085, 5913.881722365442, 5527.530159936289, 5610.943890561042, 5707.743151558273, 5837.211976383303, 5849.064149736022, 5843.152742852348, 5909.734061967308, 5915.378885217162, 5938.8218353449465, 5946.405359464192, 5716.228309178207, 5719.28508936383, 5724.026915424472, 5729.9713501432225, 5747.195392645117], "value": 5459.345565675174, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.6390333848021, 615.1326629452471, 626.8088233088909, 643.6170478565252, 655.7278729327329, 34508.30983380331, 37792.24415511688, 45230.77384613077, 45929.31106033404, 46366.30450543245, 48318.27522587164, 48459.75770121144, 48733.51266487334, 48739.51260487394, 48746.26880596785, 9187.989321174682, 9353.95323023384, 9355.766105847375, 9357.532123393838, 9366.765830854249, 8530.74407767765, 8731.039585645574, 10751.139908807316, 11062.778744425106, 11075.0, 11213.66359009227, 11285.774284514306, 11293.378864162467, 11308.547658093667, 11325.377104259262, 11062.0, 11113.44432778366, 11116.888831111706, 11121.054710349548, 11123.221374503788, 10930.234883558154, 10995.560177592886, 10998.12015038803, 10999.61501347449, 11019.449027548591, 45795.77102114502, 46063.76968115138, 46090.0, 46128.53871461276, 46215.07569848618, 3752.343339915531, 3762.5108735864437, 3774.735768496206, 3867.2265546890735, 3919.2945269851416, 31427.52858707121, 34141.14647133841, 34183.0, 34461.827690861384, 34640.653593464245, 4686.554777296152, 4720.244760838249, 4785.784639691187, 4814.759262036884, 4878.658493905428, 329425.0, 329622.0, 330458.0, 333911.0, 334651.99999999756, 39518.40722389166, 68501.31498685048, 68888.31111688819, 69098.65450672715, 69233.30766692369, 40374.59625403767, 42372.15255694869, 42377.57622423798, 42378.364324535156, 42385.78807105945, 17352.566185845455, 17523.47429577089, 17539.123043847758, 17539.473815785546, 17541.386051488138, 10821.83767243492, 11071.0, 13993.860061399255, 14065.226412547408, 14091.85908140926, 9545.236381089497, 9749.4759956084, 9824.950875245579, 9860.359076660137, 9925.702228933143, 3752.2870654575545, 3800.961990380061, 3826.827792749333, 3834.386498160337, 3849.576546579874, 1019.2373601156381, 1028.2956175020136, 1087.1085709718113, 1161.1059484197121, 1185.1289302362757, 33201.501977469874, 34149.48775768365, 34194.31611367759, 34611.653883460844, 34622.65377346244, 1164.336328292865, 1165.143619439711, 1197.3235122155954, 1239.6652903715947, 1264.9620511384674, 17288.877637633494, 17976.754969859016, 18107.909460452614, 18158.182881770354, 18219.45341639753, 510130.0, 511895.0, 512831.0, 513942.0, 515067.0, 61085.0, 61420.0, 61760.0, 61778.69110654418, 61859.69070154711, 1262.9305388203736, 1304.230504002643, 1312.9080964332595, 1425.5153247895557, 1427.1223197733527, 28930.710692893645, 33487.0, 34259.4861077089, 36227.0, 36488.087797804204, 56971.71514142569, 57772.42227577839, 57799.711001444724, 57802.421975781384, 57861.71069144627, 428502.0, 430241.0, 431687.0, 432468.0, 433478.0, 28062.2984425391, 28671.0, 30534.541981869846, 31222.843885780425, 32310.515342270355, 45611.31583026324, 49702.25446618231, 50201.49798501968, 50206.0, 51639.0, 40993.06410838122, 42523.50893987904, 42902.78548607237, 43352.56647433611, 44222.77888610536, 43288.567114328456, 44102.55897440985, 44229.77885110554, 45035.32447013232, 45071.32393014042, 42808.57191428046, 42941.570584295005, 43040.56959430491, 43050.78474607607, 43171.35242971295, 35446.645533545365, 37105.814470928555, 37484.81257593694, 37929.43105853359, 38185.80907095447, 28104.0, 28226.43547129087, 28240.85879570589, 28546.57180142341, 28641.713582863904], "value": 20350.857256327774, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.3715445409114, 422.5808913308913, 431.30129190711045, 434.33980349868193, 442.7321470510339, 18096.72854907176, 18525.62948741026, 19776.90111549444, 19918.50203744907, 20043.19827206912, 18902.243910243607, 19219.23123075079, 19257.229710811585, 19260.61478770424, 19366.612667746638, 5337.2527846101575, 5650.886982260352, 5685.061964775828, 5741.425857414246, 5773.740181691834, 5642.7742890284335, 5654.038813401731, 5699.2306038684665, 5700.116481945284, 6183.690815459209, 5946.43508866657, 6099.756009759604, 6112.816615501542, 6113.266408031042, 6115.877682446348, 5609.158626206061, 5653.434656534355, 5729.026065568843, 6096.207493025922, 6183.412575805291, 5513.972430137864, 5517.420670829545, 5519.337679478448, 5520.751566179531, 5520.889582208333, 14877.776833347509, 15214.771778423332, 15237.314320855588, 15297.388104475807, 15306.234688265542, 2468.2101727447225, 2499.7250302466714, 2569.56317426038, 2908.200244932639, 3004.804687695315, 11232.49453774582, 11460.426978651034, 15013.624659383602, 15095.773563396559, 15702.293396797171, 2001.2395289789931, 2094.9266775662777, 2105.1263725553877, 2118.03629348646, 2132.893355332227, 57220.71389643025, 65275.673621632064, 72443.0, 73463.26536734564, 85055.5747221266, 11663.0, 11832.88167118335, 11938.343391113573, 11987.160898737178, 12154.209976351509, 17132.40036598713, 17165.656686866194, 17181.82818171802, 17190.31238750461, 17196.22616982239, 8497.447665901696, 8571.95714021426, 8574.914250857537, 8645.827083458296, 8772.692955746646, 8120.878186827203, 8202.712905048294, 8299.087100418948, 8350.123237060021, 8351.0, 5056.570191533688, 5196.9740151299, 5220.817271395483, 5246.213068039749, 5281.524662780368, 2083.9672191656978, 2106.147010460766, 2159.0, 2170.0777169702815, 2183.4213933307688, 992.8411454167299, 1004.7588578741049, 1048.2871647279771, 1085.8316960871077, 1111.9444027798577, 20045.699314510293, 20225.696614550794, 20515.58968820645, 20725.58548829015, 20974.895125524275, 1023.2376879225025, 1034.177828626244, 1069.3049517813329, 1116.9385683787307, 1151.0848875144281, 10490.0, 11325.433728313552, 11398.316101033965, 11528.193026488234, 11591.710207244887, 480672.0, 486748.0, 489118.0, 491411.0, 494624.0, 68356.6582167086, 79740.20259797327, 93977.0, 95173.5241323789, 96677.0, 1019.3323373190572, 1055.931364461292, 1061.946902654864, 1123.292325834719, 1127.6053381316474, 17883.463496095137, 18056.90971545134, 18486.445406637824, 18523.259069637603, 18618.627627447106, 42538.0, 42589.0, 42688.573114269704, 43273.3508997359, 43948.780256098515, 55578.0, 58462.415375845696, 58827.41172588219, 59215.0, 60227.0, 8512.787180320542, 8536.871946920677, 8616.65533378683, 8761.123887611187, 8909.688160914337, 11461.968422841985, 11465.656030319104, 12898.226106433644, 13199.934000329937, 13406.262655553648, 10565.471726413802, 10758.193135514712, 10898.78202435931, 11005.834912476479, 11020.944895275472, 10428.843567346345, 10636.84044739345, 10840.186985976241, 11034.779304413707, 11248.662540123809, 10978.341299522055, 11078.390688512209, 11164.218504704917, 11220.0, 11288.153388495732, 8957.328200384867, 8982.191602755784, 9025.593848276712, 9054.185123338932, 9269.67556135532, 8715.869261960948, 10545.367277963347, 11121.443927803739, 11335.149863760416, 11366.090712743126], "value": 9387.88867340796, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1541.9845801541987, 1560.7190705672979, 1746.0, 1807.8824876383042, 1868.4861663042652, 9177.724668259954, 9892.258080643944, 9900.009999000096, 9908.653197138092, 9909.950450247748, 8563.571821408936, 8831.293496520278, 8831.690890818823, 9204.861927071099, 9753.707388778348, 2485.9751402486013, 2525.5201511712717, 2537.1120107962156, 2539.0351666366846, 2541.8220724549196, 2435.9634605480933, 2495.238952119603, 2504.136073054802, 2508.6989561252585, 2510.0, 2459.27451401836, 2461.4215659320043, 2483.8758062096913, 2499.825012249143, 2508.7867531259867, 2433.2943446400523, 2434.8782560871973, 2441.56051910656, 2511.6860392450944, 2518.3074654469983, 2435.7442468540903, 2436.074291769134, 2441.841280316774, 2445.376429010591, 2496.188738659943, 9729.173020293283, 9781.853272200922, 9832.262580306506, 9839.212862971017, 9850.0, 5522.5581953443625, 5615.859603509904, 5643.294588176478, 5648.548116150698, 5650.576206784466, 3418.2138108234994, 3528.982355088234, 3538.9115272118147, 3567.090391950062, 3600.891973240807, 1256.7245572232114, 1325.5426877727168, 1327.482281910056, 1327.8472975607735, 1336.6791969927244, 13333.399997000159, 13346.33268336589, 13349.666258343523, 13362.0, 13368.197908125447, 4829.782659780319, 5218.608604354688, 5223.764930578133, 5235.685858848481, 5247.2129180623215, 11267.098632109411, 11300.20898537111, 11300.604478843201, 11301.886981130083, 11305.095592352593, 5811.982902991959, 5841.853953651193, 5848.590598658053, 5851.502622277154, 5862.03276459388, 4376.450058498079, 5259.894802103937, 5318.680879147263, 5375.9462405376225, 5529.529989950899, 4481.551844815557, 4487.461504619467, 4490.348899409567, 4497.235469970113, 4568.0, 1378.152436251718, 1382.3710211853584, 1388.7917511764626, 1393.2476462710024, 1400.2438683111209, 985.6402413119304, 986.6201512417771, 995.2386424385351, 1005.5424781724298, 1018.3787889387615, 6233.625982440977, 6260.342664020212, 6318.147050148263, 6394.1687580614225, 6529.314421985718, 497.1796535716097, 498.68831980012493, 507.51785803486837, 510.7982346972925, 522.1723568144457, 3962.0293028208275, 4063.3092374295848, 4135.937960930589, 4172.7913604319665, 4175.62419382257, 12032.338221397733, 12044.15690901646, 12323.260604363766, 12406.379681015913, 12440.75118497643, 12204.511819527119, 12306.200096993667, 12320.0, 12324.137310388187, 12328.445219965122, 8980.775480612907, 9007.504587247633, 9035.096490350912, 9110.863337050083, 9150.679726209552, 6322.146510221245, 6404.359564043559, 6407.679616019273, 6447.580907241015, 6556.114924485133, 10782.568697252022, 11208.383538905438, 11245.493952771982, 11284.815094414967, 11433.656990290305, 11341.546338146713, 11554.653360399201, 11561.768764624829, 11591.76816463649, 11654.883451165719, 7918.604069796603, 8165.1018387978465, 8409.285210757154, 8720.78198045054, 8961.775955601162, 9319.767005824908, 9656.75858103553, 9665.516724163905, 9667.129958303787, 9699.224062075158, 8590.527520986405, 8594.527300998256, 8617.526036068077, 8629.180227878342, 8710.651573936972, 8132.3494120471405, 8249.628766705633, 8259.967504061991, 8335.624896879533, 8521.957390213258, 7030.648467576703, 7199.316064973819, 7234.276572342724, 7436.144843343085, 7443.627818609156, 5226.660267082628, 5374.865628359323, 5397.487238712316, 5505.752241149078, 5714.685692286964, 5332.893342133058, 5379.757910893941, 5518.0, 5576.749046292845, 5583.525400341016], "value": 4948.837768789253, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.8030842882201, 359.38903863432165, 367.6286950180318, 372.1292176307438, 375.71257987639444, 5515.428102990649, 5534.501894829465, 5569.554435645149, 5571.972140139299, 5604.075327570956, 5103.311053007852, 5290.894182116355, 5291.31212942317, 5291.6031297652635, 5440.972795136019, 4208.494980602332, 4287.1425714857, 4361.411209486726, 4386.736795792247, 4410.228210063242, 4348.456442944632, 4362.214801335758, 4366.868993930171, 4379.58393952574, 4394.274944634131, 4071.1043570414463, 4236.0, 4236.555161708023, 4278.828846846122, 4323.0, 4231.83072677091, 4246.681498887596, 4249.723767955088, 4250.617444430016, 4253.107886637085, 3757.89142203048, 3759.342115129841, 3760.078780698719, 3766.303233901737, 3783.3946568549177, 5241.842744717665, 5313.256144139824, 5322.467753224647, 5387.703676297802, 5401.972990135064, 4901.779419926112, 4901.852944411673, 4912.754362281908, 4918.458969513386, 4926.142837154478, 5709.628874123168, 5716.485516303511, 5744.770209191627, 5754.165645981351, 5775.537956963432, 4036.374361973899, 4158.625723684883, 4164.12553363794, 4165.416841642173, 4231.87304380869, 5865.472107510302, 5903.0, 5933.406659334032, 5937.020391635375, 5951.404859514014, 4266.253405653998, 4266.759951025736, 4292.141571685675, 4312.935305970413, 4323.740575565476, 4109.671226301889, 4321.91952011997, 4341.218580655449, 4372.540883207217, 4387.561243875587, 4876.8295609053575, 4888.3114287141925, 4893.168161412568, 4900.436449808318, 4903.5586797188425, 5690.374058853523, 5744.827655170351, 5746.195532625436, 5779.566532510079, 5814.505767009851, 1450.3835869755312, 1483.5845963130341, 1485.4949317231976, 1497.9026363286353, 1516.696660667871, 954.5990683912773, 960.8078384323163, 961.5144352102144, 977.3305285879053, 982.6904525074578, 4924.285978533093, 4977.751112444435, 4982.676126051795, 4990.675606085593, 4996.300517927493, 5102.520269121913, 5149.845504634867, 5159.684280508446, 5166.664166829144, 5181.8340873303205, 4735.792372944877, 4935.481774413706, 4942.654014218971, 4953.826616068421, 4964.925526117111, 2739.233014755832, 2741.930647047653, 2747.6290700755544, 2750.22993561803, 2752.4357506711076, 5210.635255532076, 5236.24074509194, 5236.607254455931, 5278.419373868871, 5326.334208223972, 4893.510648935078, 5159.2003239497935, 5189.89809127304, 5217.869553261199, 5232.581393488512, 5250.553702935294, 5251.947480525146, 5273.815416460406, 5287.867803304871, 5326.280952071498, 5140.76866541014, 5205.375354957429, 5234.7906083756225, 5236.0, 5287.312649355559, 4752.572268495852, 5025.853670721743, 5063.822766203165, 5096.949030509648, 5103.7192954387865, 5175.645081487989, 5205.189197833279, 5227.065985585357, 5264.9736751315995, 5269.4730526947, 3795.8291876865055, 3803.106270026597, 3805.3340665384003, 3820.8280627371278, 4015.13674559971, 5290.153575427913, 5677.233573467694, 5751.568632352507, 5885.411458854252, 5894.6757928314355, 5732.226149469769, 5745.971270143623, 5750.539956803529, 5759.625624334572, 5773.942260577341, 5484.351118348108, 5759.827205183851, 5795.275590551181, 5807.332156801853, 5820.854478638068, 5742.885142297214, 5746.5402767779315, 5751.597388182954, 5765.4811067004175, 5774.335951365647, 5685.516731077904, 5799.507041901317, 5819.447152520504, 5827.970860145672, 5871.383504732113, 5644.81458893637, 5694.914576281276, 5700.287464066992, 5702.40124786908, 5705.771769129188], "value": 4229.872298252759, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [820.7032888036903, 820.8194197276597, 849.745076477057, 870.1689886158717, 888.6134531478812, 16283.104429256386, 17825.28698852046, 17848.37530686426, 17911.462656120304, 17911.910440447813, 14955.700885982274, 15057.774133388008, 15061.096334219954, 15091.09453432792, 15102.697946041073, 705.28413660135, 722.4689852958098, 842.2335674536173, 861.543382007537, 868.2316150207049, 853.8206976534935, 856.8029353248756, 856.8629019356904, 857.2413414128509, 857.5626430520448, 897.4480694372979, 897.8922529296461, 906.9909300906972, 908.6592527802075, 909.0182602789005, 897.5601955042015, 901.3645380007111, 903.3315346643502, 903.5843511984496, 903.8915330160357, 667.0561155964305, 668.4719071933167, 668.8762578922915, 669.2571245917028, 669.6183175589915, 14622.341994610268, 14743.26283685822, 14747.410103595843, 14768.187749673763, 14773.187474688888, 13463.259520726357, 13810.723785524333, 13842.0, 14124.081934674214, 16264.593385165466, 13723.45106195751, 13849.861501384958, 13886.305684715824, 14045.43818247269, 14282.0, 4673.789679464398, 4727.479977202505, 4756.548127927841, 4764.309175169616, 4791.161546729343, 82067.0, 83473.0, 84178.57910710407, 84645.0, 84958.57520712419, 11468.713282168013, 11662.0, 11693.064554835593, 11767.764644707058, 11898.881011189951, 19312.8068719311, 19426.22295108208, 19431.125599348063, 19475.513112172026, 21140.577188456144, 8859.11408859109, 9087.591058402388, 9189.954050229706, 9267.72196834096, 9324.25405967521, 4516.480604730433, 4873.31773551703, 4874.731889746098, 5022.648414610942, 5263.526282634582, 3763.5483741950593, 3894.668953139015, 3903.7072219583647, 3931.722190288168, 3931.901702457404, 663.0882536512296, 675.061664286642, 676.5027704637088, 694.1808665774333, 701.4038067642463, 709.4076446167508, 720.2833180984953, 768.108993567459, 769.7806125254276, 802.101646156297, 9640.276979226446, 9874.555644995993, 9990.700278991642, 10208.846867296996, 10211.0, 636.3382082634101, 660.41883142834, 736.5249414127858, 764.5221736414741, 775.6238224461132, 4868.367112275381, 5046.646734728607, 5108.310378098983, 5110.66780659256, 5191.662541934762, 70059.64970175117, 80590.3586748922, 114357.0, 122056.0, 140333.0, 80400.0, 112032.0, 117715.41142294405, 118907.40546297214, 121821.0, 100609.49695251478, 101037.0, 101126.49436752769, 103944.48027759812, 104000.47999759953, 9506.382085164441, 9682.322237443594, 9772.511374431107, 9857.11285984265, 9884.505774711091, 56667.0, 56766.14850777324, 57686.13470797858, 57856.0, 58909.705451472466, 50861.491385085676, 52079.479205208976, 60930.0, 69717.16555589491, 78651.60674196592, 13603.523876664269, 13903.930480347533, 13958.23229722375, 14110.858891410955, 14192.574222773334, 15178.0, 15389.613310476027, 15624.687506249584, 16149.67700646004, 16976.0, 14183.0, 14518.419263229775, 14617.19605421712, 14735.189564574051, 14755.188464634548, 13822.447102116204, 14110.78833817473, 14150.78773818414, 14201.431942722176, 14416.639584010065, 14489.492867749577, 14642.487512936996, 14916.25418729081, 15228.77156842626, 15300.736213362738, 11468.900310172849, 11737.119716021503, 12061.276323420623, 12077.939610301892, 12146.574869879865, 11970.820437693616, 12025.218360806519, 12040.157188996685, 12052.939735301617, 12365.443555040225], "value": 7983.902391387096, "unit": "score"}], "name": "dromaeo_css", "value": 7474.176933493285, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 110.0, 110.0, 111.0, 109.0, 109.0, 110.0, 109.0, 109.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 116.0, 115.0, 157.0, 117.0, 117.0, 116.0, 119.0, 149.0, 116.0], "value": 126.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 160.0, 160.0, 160.0, 159.0, 160.0, 160.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 111.0, 77.0, 77.0, 75.0, 75.0, 95.0, 74.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 125.0, 82.0, 82.0, 81.0, 98.0, 80.0, 80.0, 110.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 52.0, 50.0, 50.0, 49.0, 55.0, 51.0, 50.0, 51.0], "value": 50.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 58.0, 57.0, 57.0, 58.0, 57.0, 57.0, 57.0], "value": 57.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 73.0, 73.0, 73.0, 75.0, 83.0, 75.0, 74.0, 73.0, 82.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 129.0, 125.0, 130.0, 127.0, 124.0, 119.0, 122.0, 172.0, 127.0], "value": 130.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 162.0, 156.0, 158.0, 155.0, 153.0, 157.0, 153.0, 155.0, 162.0], "value": 156.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 62.0, 63.0, 76.0, 62.0, 63.0, 62.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1461.2, "alertThreshold": 2.0}]} 11:26:18 INFO - Return code: 0 11:26:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:26:18 INFO - # TBPL SUCCESS # 11:26:18 INFO - Running post-action listener: _resource_record_post_action 11:26:18 INFO - [mozharness: 2017-01-12 19:26:18.958877Z] Finished run-tests step (success) 11:26:18 INFO - Running post-run listener: _resource_record_post_run 11:26:19 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 8192; Write bytes: 319139840; Read time: 44; Write time: 217364 11:26:19 INFO - TinderboxPrint: CPU usage
13.0% 11:26:19 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 44 11:26:19 INFO - TinderboxPrint: I/O write bytes / time
319,139,840 / 217,364 11:26:19 INFO - TinderboxPrint: CPU idle
8,243.4 (87.0%) 11:26:19 INFO - TinderboxPrint: CPU user
1,187.3 (12.5%) 11:26:19 INFO - TinderboxPrint: Swap in / out
0 / 0 11:26:19 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 100343808; Read time: 0; Write time: 94184 11:26:19 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 218796032; Read time: 44; Write time: 123180 11:26:19 INFO - Running post-run listener: _upload_blobber_files 11:26:19 INFO - Blob upload gear active. 11:26:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:26:19 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 11:26:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:26:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:26:19 INFO - (blobuploader) - INFO - Open directory for files ... 11:26:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:26:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:26:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:23 INFO - (blobuploader) - INFO - Done attempting. 11:26:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:26:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:26:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:24 INFO - (blobuploader) - INFO - Done attempting. 11:26:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:26:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:26:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:24 INFO - (blobuploader) - INFO - Done attempting. 11:26:24 INFO - (blobuploader) - INFO - Iteration through files over. 11:26:24 INFO - Return code: 0 11:26:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:26:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:26:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/00ae5cc9494a253c93db71b0dedc7c2218aeb112e65afc7d7d1e54207191c82ee407d81867985711abf05bd6c7a89886e8e48fa711396ab54bc3a38dfbd000cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/058fa7478a51d206c77121d7e27f2dbbfafbcc52589d220bff662a97d36eb6932a41ee6beb4c605abc88b931afe5a0270906a8bca396a3c5a73704ffe2227218", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/66ee2e718e68897f7cdae21777c69d62f98233d906cbd9d189ff9cdbd39df244ff98abaab64bc9c73341e648984a86e71836fecacf93c4b6a67878dcf0d23f22"} 11:26:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:26:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:26:24 INFO - Contents: 11:26:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/00ae5cc9494a253c93db71b0dedc7c2218aeb112e65afc7d7d1e54207191c82ee407d81867985711abf05bd6c7a89886e8e48fa711396ab54bc3a38dfbd000cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/058fa7478a51d206c77121d7e27f2dbbfafbcc52589d220bff662a97d36eb6932a41ee6beb4c605abc88b931afe5a0270906a8bca396a3c5a73704ffe2227218", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/66ee2e718e68897f7cdae21777c69d62f98233d906cbd9d189ff9cdbd39df244ff98abaab64bc9c73341e648984a86e71836fecacf93c4b6a67878dcf0d23f22"} 11:26:24 INFO - Running post-run listener: copy_logs_to_upload_dir 11:26:24 INFO - Copying logs to upload dir... 11:26:24 INFO - mkdir: /builds/slave/test/build/upload/logs 11:26:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.118411 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-01-12 11:26:24.300112) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 11:26:24.303679) ========= 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=d2a8c569965ab8367867b893000001a1-1484247951.510518-1121475325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/00ae5cc9494a253c93db71b0dedc7c2218aeb112e65afc7d7d1e54207191c82ee407d81867985711abf05bd6c7a89886e8e48fa711396ab54bc3a38dfbd000cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/058fa7478a51d206c77121d7e27f2dbbfafbcc52589d220bff662a97d36eb6932a41ee6beb4c605abc88b931afe5a0270906a8bca396a3c5a73704ffe2227218", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/66ee2e718e68897f7cdae21777c69d62f98233d906cbd9d189ff9cdbd39df244ff98abaab64bc9c73341e648984a86e71836fecacf93c4b6a67878dcf0d23f22"} build_url:https://queue.taskcluster.net/v1/task/LnMrit2RSa-UWUWWFHMH4Q/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011421 build_url: 'https://queue.taskcluster.net/v1/task/LnMrit2RSa-UWUWWFHMH4Q/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/00ae5cc9494a253c93db71b0dedc7c2218aeb112e65afc7d7d1e54207191c82ee407d81867985711abf05bd6c7a89886e8e48fa711396ab54bc3a38dfbd000cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/058fa7478a51d206c77121d7e27f2dbbfafbcc52589d220bff662a97d36eb6932a41ee6beb4c605abc88b931afe5a0270906a8bca396a3c5a73704ffe2227218", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/66ee2e718e68897f7cdae21777c69d62f98233d906cbd9d189ff9cdbd39df244ff98abaab64bc9c73341e648984a86e71836fecacf93c4b6a67878dcf0d23f22"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 11:26:24.329052) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 11:26:24.329406) ========= 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=d2a8c569965ab8367867b893000001a1-1484247951.510518-1121475325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004396 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 11:26:24.412270) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 11:26:24.412609) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 11:26:24.412943) ========= ========= Total master_lag: 0.17 =========