builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1477592350.79 results: success (0) buildid: 20161027080634 builduid: 3d7412e364db481480b31c041f634a01 revision: 7b654728d154b6f60ae94f6498d6a2470e76f994 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 11:19:10.792506) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 11:19:10.793029) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 11:19:10.793315) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 11:19:10.808827) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 11:19:10.809170) ========= 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=db0483c52d987ecb441a263b000001ad-1477592350.353143-124687251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-27 11:19:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 29.6M=0s 2016-10-27 11:19:11 (29.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117408 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 11:19:10.940838) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 11:19:10.941192) ========= 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=db0483c52d987ecb441a263b000001ad-1477592350.353143-124687251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018533 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 11:19:10.991469) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-27 11:19:10.991825) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7b654728d154b6f60ae94f6498d6a2470e76f994 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7b654728d154b6f60ae94f6498d6a2470e76f994 --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=db0483c52d987ecb441a263b000001ad-1477592350.353143-124687251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-27 11:19:11,289 truncating revision to first 12 chars 2016-10-27 11:19:11,289 Setting DEBUG logging. 2016-10-27 11:19:11,289 attempt 1/10 2016-10-27 11:19:11,289 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7b654728d154?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-27 11:19:11,965 unpacking tar archive at: mozilla-aurora-7b654728d154/testing/mozharness/ program finished with exit code 0 elapsedTime=1.013329 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-27 11:19:12.018638) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 11:19:12.019187) ========= script_repo_revision: 7b654728d154b6f60ae94f6498d6a2470e76f994 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 11:19:12.019615) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 11:19:12.019880) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 11:19:12.029033) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-10-27 11:19:12.029396) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1477592350.353143-124687251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:19:12 INFO - MultiFileLogger online at 20161027 11:19:12 in /builds/slave/test 11:19:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:19:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:19:12 INFO - {'append_to_log': False, 11:19:12 INFO - 'base_work_dir': '/builds/slave/test', 11:19:12 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:19:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:19:12 INFO - 'branch': 'Mozilla-Aurora', 11:19:12 INFO - 'buildbot_json_path': 'buildprops.json', 11:19:12 INFO - 'config_files': ('talos/linux_config.py',), 11:19:12 INFO - 'default_actions': ('clobber', 11:19:12 INFO - 'read-buildbot-config', 11:19:12 INFO - 'download-and-extract', 11:19:12 INFO - 'populate-webroot', 11:19:12 INFO - 'create-virtualenv', 11:19:12 INFO - 'install', 11:19:12 INFO - 'run-tests'), 11:19:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:19:12 INFO - 'download_minidump_stackwalk': True, 11:19:12 INFO - 'download_symbols': 'ondemand', 11:19:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:19:12 INFO - 'tooltool.py': '/tools/tooltool.py', 11:19:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:19:12 INFO - '/tools/misc-python/virtualenv.py')}, 11:19:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:19:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:19:12 INFO - 'installer_path': 'installer.exe', 11:19:12 INFO - 'log_level': 'info', 11:19:12 INFO - 'log_name': 'talos', 11:19:12 INFO - 'log_to_console': True, 11:19:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:19:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:19:12 INFO - 'opt_config_files': (), 11:19:12 INFO - 'pip_index': False, 11:19:12 INFO - 'sps_profile': False, 11:19:12 INFO - 'sps_profile_interval': 0, 11:19:12 INFO - 'suite': 'dromaeojs', 11:19:12 INFO - 'system_bits': '32', 11:19:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:19:12 INFO - 'title': 'talos-linux64-ix-031', 11:19:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:19:12 INFO - 'use_talos_json': True, 11:19:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:19:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:19:12 INFO - 'work_dir': 'build'} 11:19:12 INFO - [mozharness: 2016-10-27 18:19:12.421000Z] Running clobber step. 11:19:12 INFO - Running pre-action listener: _resource_record_pre_action 11:19:12 INFO - Running main action method: clobber 11:19:12 INFO - rmtree: /builds/slave/test/build 11:19:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:19:13 INFO - Running post-action listener: _resource_record_post_action 11:19:13 INFO - [mozharness: 2016-10-27 18:19:13.412741Z] Finished clobber step (success) 11:19:13 INFO - [mozharness: 2016-10-27 18:19:13.412839Z] Running read-buildbot-config step. 11:19:13 INFO - Running pre-action listener: _resource_record_pre_action 11:19:13 INFO - Running main action method: read_buildbot_config 11:19:13 INFO - Using buildbot properties: 11:19:13 INFO - { 11:19:13 INFO - "project": "", 11:19:13 INFO - "product": "firefox", 11:19:13 INFO - "script_repo_revision": "production", 11:19:13 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 11:19:13 INFO - "repository": "", 11:19:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 11:19:13 INFO - "buildid": "20161027080634", 11:19:13 INFO - "pgo_build": "True", 11:19:13 INFO - "basedir": "/builds/slave/test", 11:19:13 INFO - "buildnumber": 596, 11:19:13 INFO - "slavename": "talos-linux64-ix-031", 11:19:13 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:19:13 INFO - "platform": "ubuntu64_hw", 11:19:13 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:19:13 INFO - "branch": "mozilla-aurora", 11:19:13 INFO - "repo_path": "releases/mozilla-aurora", 11:19:13 INFO - "revision": "7b654728d154b6f60ae94f6498d6a2470e76f994", 11:19:13 INFO - "stage_platform": "linux64-pgo", 11:19:13 INFO - "builduid": "3d7412e364db481480b31c041f634a01", 11:19:13 INFO - "slavebuilddir": "test" 11:19:13 INFO - } 11:19:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/S6Nj6k24QsyOG113-d7gww/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 11:19:13 INFO - Running post-action listener: _resource_record_post_action 11:19:13 INFO - [mozharness: 2016-10-27 18:19:13.415573Z] Finished read-buildbot-config step (success) 11:19:13 INFO - [mozharness: 2016-10-27 18:19:13.415662Z] Running download-and-extract step. 11:19:13 INFO - Running pre-action listener: _resource_record_pre_action 11:19:13 INFO - Running main action method: download_and_extract 11:19:13 INFO - mkdir: /builds/slave/test/build/tests 11:19:13 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:19:13 INFO - trying https://queue.taskcluster.net/v1/task/S6Nj6k24QsyOG113-d7gww/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 11:19:13 INFO - Downloading https://queue.taskcluster.net/v1/task/S6Nj6k24QsyOG113-d7gww/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 11:19:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S6Nj6k24QsyOG113-d7gww/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:19:14 INFO - Downloaded 1361 bytes. 11:19:14 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 11:19:14 INFO - Using the following test package requirements: 11:19:14 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 11:19:14 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 11:19:14 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:19:14 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 11:19:14 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:19:14 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 11:19:14 INFO - u'jsshell-linux-x86_64.zip'], 11:19:14 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 11:19:14 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:19:14 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 11:19:14 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 11:19:14 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:19:14 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 11:19:14 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:19:14 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 11:19:14 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:19:14 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 11:19:14 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:19:14 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:19:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S6Nj6k24QsyOG113-d7gww/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 11:19:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S6Nj6k24QsyOG113-d7gww/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:19:14 INFO - Fetch https://queue.taskcluster.net/v1/task/S6Nj6k24QsyOG113-d7gww/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 11:19:14 INFO - Expected file size: 21894604 11:19:19 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:19:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S6Nj6k24QsyOG113-d7gww/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 11:19:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S6Nj6k24QsyOG113-d7gww/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:19:19 INFO - Fetch https://queue.taskcluster.net/v1/task/S6Nj6k24QsyOG113-d7gww/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 11:19:19 INFO - Expected file size: 21894604 11:19:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S6Nj6k24QsyOG113-d7gww/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 11:19:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S6Nj6k24QsyOG113-d7gww/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:19:24 INFO - Fetch https://queue.taskcluster.net/v1/task/S6Nj6k24QsyOG113-d7gww/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 11:19:24 INFO - Expected file size: 14414081 11:19:25 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:19:25 INFO - trying https://queue.taskcluster.net/v1/task/S6Nj6k24QsyOG113-d7gww/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 11:19:25 INFO - Downloading https://queue.taskcluster.net/v1/task/S6Nj6k24QsyOG113-d7gww/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 11:19:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S6Nj6k24QsyOG113-d7gww/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:19:26 INFO - Downloaded 63963761 bytes. 11:19:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S6Nj6k24QsyOG113-d7gww/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 11:19:26 INFO - mkdir: /builds/slave/test/properties 11:19:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:19:26 INFO - Writing to file /builds/slave/test/properties/build_url 11:19:26 INFO - Contents: 11:19:26 INFO - build_url:https://queue.taskcluster.net/v1/task/S6Nj6k24QsyOG113-d7gww/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 11:19:27 INFO - Running post-action listener: _resource_record_post_action 11:19:27 INFO - Running post-action listener: set_extra_try_arguments 11:19:27 INFO - [mozharness: 2016-10-27 18:19:27.092506Z] Finished download-and-extract step (success) 11:19:27 INFO - [mozharness: 2016-10-27 18:19:27.092735Z] Running populate-webroot step. 11:19:27 INFO - Running pre-action listener: _resource_record_pre_action 11:19:27 INFO - Running main action method: populate_webroot 11:19:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:19:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:19:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:19:27 INFO - '--tppagecycles', 11:19:27 INFO - '7'], 11:19:27 INFO - 'tests': ['tsvgm']}}, 11:19:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:19:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:19:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:19:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:19:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:19:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:19:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:19:27 INFO - 'talos_options': ['--disable-e10s'], 11:19:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:19:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:19:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:19:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:19:27 INFO - 'talos_options': ['--disable-e10s'], 11:19:27 INFO - 'tests': ['damp', 'tps']}, 11:19:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:19:27 INFO - 'tests': ['damp', 'tps']}, 11:19:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:19:27 INFO - 'tests': ['dromaeo_dom']}, 11:19:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:19:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:19:27 INFO - 'tests': ['basic_compositor_video']}, 11:19:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:19:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:19:27 INFO - 'tests': ['a11yr', 11:19:27 INFO - 'ts_paint', 11:19:27 INFO - 'tpaint', 11:19:27 INFO - 'sessionrestore', 11:19:27 INFO - 'sessionrestore_no_auto_restore', 11:19:27 INFO - 'tabpaint']}, 11:19:27 INFO - 'other-e10s': {'tests': ['a11yr', 11:19:27 INFO - 'ts_paint', 11:19:27 INFO - 'tpaint', 11:19:27 INFO - 'sessionrestore', 11:19:27 INFO - 'sessionrestore_no_auto_restore', 11:19:27 INFO - 'tabpaint']}, 11:19:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:19:27 INFO - 'ts_paint', 11:19:27 INFO - 'tpaint', 11:19:27 INFO - 'sessionrestore', 11:19:27 INFO - 'sessionrestore_no_auto_restore', 11:19:27 INFO - 'tabpaint']}, 11:19:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:19:27 INFO - 'ts_paint', 11:19:27 INFO - 'tpaint', 11:19:27 INFO - 'sessionrestore', 11:19:27 INFO - 'sessionrestore_no_auto_restore', 11:19:27 INFO - 'tabpaint']}, 11:19:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:19:27 INFO - 'tests': ['a11yr', 11:19:27 INFO - 'ts_paint', 11:19:27 INFO - 'tpaint', 11:19:27 INFO - 'sessionrestore', 11:19:27 INFO - 'sessionrestore_no_auto_restore', 11:19:27 INFO - 'tabpaint']}, 11:19:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:19:27 INFO - 'tests': ['a11yr', 11:19:27 INFO - 'ts_paint', 11:19:27 INFO - 'tpaint', 11:19:27 INFO - 'sessionrestore', 11:19:27 INFO - 'sessionrestore_no_auto_restore', 11:19:27 INFO - 'tabpaint']}, 11:19:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:19:27 INFO - 'tests': ['tsvgx', 11:19:27 INFO - 'tsvgr_opacity', 11:19:27 INFO - 'tart', 11:19:27 INFO - 'tscrollx', 11:19:27 INFO - 'cart']}, 11:19:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:19:27 INFO - 'tsvgr_opacity', 11:19:27 INFO - 'tart', 11:19:27 INFO - 'tscrollx', 11:19:27 INFO - 'cart']}, 11:19:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:19:27 INFO - 'talos_options': ['--disable-e10s'], 11:19:27 INFO - 'tests': ['tp5o']}, 11:19:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:19:27 INFO - 'tests': ['tp5o']}, 11:19:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:19:27 INFO - 'talos_options': ['--disable-e10s', 11:19:27 INFO - '--xperf_path', 11:19:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:19:27 INFO - 'tests': ['tp5n']}, 11:19:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:19:27 INFO - 'talos_options': ['--xperf_path', 11:19:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:19:27 INFO - 'tests': ['tp5n']}}, 11:19:27 INFO - 'talos.zip': {'path': '', 11:19:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:19:27 INFO - Running post-action listener: _resource_record_post_action 11:19:27 INFO - [mozharness: 2016-10-27 18:19:27.114086Z] Finished populate-webroot step (success) 11:19:27 INFO - [mozharness: 2016-10-27 18:19:27.114175Z] Running create-virtualenv step. 11:19:27 INFO - Running pre-action listener: _resource_record_pre_action 11:19:27 INFO - Running main action method: create_virtualenv 11:19:27 INFO - Creating virtualenv /builds/slave/test/build/venv 11:19:27 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:19:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:19:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:19:27 INFO - Using real prefix '/usr' 11:19:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:19:27 INFO - Installing distribute.............................................................................................................................................................................................done. 11:19:29 INFO - Installing pip.................done. 11:19:29 INFO - Return code: 0 11:19:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:19:29 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:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:29 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:19:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:29 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 0x7eff26b8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98f60>, '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 0x1a99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477592350.353143-124687251', '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:19:29 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:19:29 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:19:29 INFO - Using env: {'DISPLAY': ':0', 11:19:29 INFO - 'HOME': '/home/cltbld', 11:19:29 INFO - 'LANG': 'en_US.UTF-8', 11:19:29 INFO - 'LANGUAGE': 'en_US:en', 11:19:29 INFO - 'LOGNAME': 'cltbld', 11:19:29 INFO - 'MAIL': '/var/mail/cltbld', 11:19:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:29 INFO - 'MOZ_NO_REMOTE': '1', 11:19:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:29 INFO - 'NO_EM_RESTART': '1', 11:19:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:29 INFO - 'PWD': '/builds/slave/test', 11:19:29 INFO - 'SHELL': '/bin/bash', 11:19:29 INFO - 'SHLVL': '1', 11:19:29 INFO - 'TERM': 'linux', 11:19:29 INFO - 'TMOUT': '86400', 11:19:29 INFO - 'USER': 'cltbld', 11:19:29 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477592350.353143-124687251', 11:19:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:29 INFO - '_': '/tools/buildbot/bin/python'} 11:19:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:29 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:19:29 INFO - Cleaning up... 11:19:29 INFO - Return code: 0 11:19:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:19:29 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:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:29 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:19:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:29 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 0x7eff26b8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98f60>, '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 0x1a99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477592350.353143-124687251', '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:19:29 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:19:29 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:19:29 INFO - Using env: {'DISPLAY': ':0', 11:19:29 INFO - 'HOME': '/home/cltbld', 11:19:29 INFO - 'LANG': 'en_US.UTF-8', 11:19:29 INFO - 'LANGUAGE': 'en_US:en', 11:19:29 INFO - 'LOGNAME': 'cltbld', 11:19:29 INFO - 'MAIL': '/var/mail/cltbld', 11:19:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:29 INFO - 'MOZ_NO_REMOTE': '1', 11:19:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:29 INFO - 'NO_EM_RESTART': '1', 11:19:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:29 INFO - 'PWD': '/builds/slave/test', 11:19:29 INFO - 'SHELL': '/bin/bash', 11:19:29 INFO - 'SHLVL': '1', 11:19:29 INFO - 'TERM': 'linux', 11:19:29 INFO - 'TMOUT': '86400', 11:19:29 INFO - 'USER': 'cltbld', 11:19:29 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477592350.353143-124687251', 11:19:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:29 INFO - '_': '/tools/buildbot/bin/python'} 11:19:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:30 INFO - Downloading/unpacking psutil>=3.1.1 11:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:19:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:19:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:19:32 INFO - Installing collected packages: psutil 11:19:32 INFO - Running setup.py install for psutil 11:19:32 INFO - building 'psutil._psutil_linux' extension 11:19:32 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:19:32 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:19:32 INFO - building 'psutil._psutil_posix' extension 11:19:32 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:19:32 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:19:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:19:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:19:32 INFO - Successfully installed psutil 11:19:32 INFO - Cleaning up... 11:19:32 INFO - Return code: 0 11:19:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7eff26b8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98f60>, '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 0x1a99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477592350.353143-124687251', '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:19:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:19:32 INFO - Using env: {'DISPLAY': ':0', 11:19:32 INFO - 'HOME': '/home/cltbld', 11:19:32 INFO - 'LANG': 'en_US.UTF-8', 11:19:32 INFO - 'LANGUAGE': 'en_US:en', 11:19:32 INFO - 'LOGNAME': 'cltbld', 11:19:32 INFO - 'MAIL': '/var/mail/cltbld', 11:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:32 INFO - 'MOZ_NO_REMOTE': '1', 11:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:32 INFO - 'NO_EM_RESTART': '1', 11:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:32 INFO - 'PWD': '/builds/slave/test', 11:19:32 INFO - 'SHELL': '/bin/bash', 11:19:32 INFO - 'SHLVL': '1', 11:19:32 INFO - 'TERM': 'linux', 11:19:32 INFO - 'TMOUT': '86400', 11:19:32 INFO - 'USER': 'cltbld', 11:19:32 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477592350.353143-124687251', 11:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:32 INFO - '_': '/tools/buildbot/bin/python'} 11:19:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:19:33 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:19:33 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:19:33 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:19:33 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:19:33 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:19:33 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:19:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:19:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:19:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:19:35 INFO - Installing collected packages: mozsystemmonitor 11:19:35 INFO - Running setup.py install for mozsystemmonitor 11:19:35 INFO - Successfully installed mozsystemmonitor 11:19:35 INFO - Cleaning up... 11:19:35 INFO - Return code: 0 11:19:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:19:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7eff26b8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98f60>, '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 0x1a99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477592350.353143-124687251', '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:19:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:19:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:19:35 INFO - Using env: {'DISPLAY': ':0', 11:19:35 INFO - 'HOME': '/home/cltbld', 11:19:35 INFO - 'LANG': 'en_US.UTF-8', 11:19:35 INFO - 'LANGUAGE': 'en_US:en', 11:19:35 INFO - 'LOGNAME': 'cltbld', 11:19:35 INFO - 'MAIL': '/var/mail/cltbld', 11:19:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:35 INFO - 'MOZ_NO_REMOTE': '1', 11:19:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:35 INFO - 'NO_EM_RESTART': '1', 11:19:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:35 INFO - 'PWD': '/builds/slave/test', 11:19:35 INFO - 'SHELL': '/bin/bash', 11:19:35 INFO - 'SHLVL': '1', 11:19:35 INFO - 'TERM': 'linux', 11:19:35 INFO - 'TMOUT': '86400', 11:19:35 INFO - 'USER': 'cltbld', 11:19:35 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477592350.353143-124687251', 11:19:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:35 INFO - '_': '/tools/buildbot/bin/python'} 11:19:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:35 INFO - Downloading/unpacking jsonschema==2.5.1 11:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:19:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:37 INFO - Downloading functools32-3.2.3-2.tar.gz 11:19:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:19:37 INFO - warning: no files found matching '*.txt' 11:19:37 INFO - no previously-included directories found matching 'build' 11:19:37 INFO - no previously-included directories found matching 'dist' 11:19:37 INFO - no previously-included directories found matching '.git*' 11:19:37 INFO - Installing collected packages: jsonschema, functools32 11:19:37 INFO - Running setup.py install for functools32 11:19:37 INFO - warning: no files found matching '*.txt' 11:19:37 INFO - no previously-included directories found matching 'build' 11:19:37 INFO - no previously-included directories found matching 'dist' 11:19:37 INFO - no previously-included directories found matching '.git*' 11:19:37 INFO - Successfully installed jsonschema functools32 11:19:37 INFO - Cleaning up... 11:19:37 INFO - Return code: 0 11:19:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7eff26b8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98f60>, '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 0x1a99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477592350.353143-124687251', '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:19:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:19:37 INFO - Using env: {'DISPLAY': ':0', 11:19:37 INFO - 'HOME': '/home/cltbld', 11:19:37 INFO - 'LANG': 'en_US.UTF-8', 11:19:37 INFO - 'LANGUAGE': 'en_US:en', 11:19:37 INFO - 'LOGNAME': 'cltbld', 11:19:37 INFO - 'MAIL': '/var/mail/cltbld', 11:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:37 INFO - 'MOZ_NO_REMOTE': '1', 11:19:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:37 INFO - 'NO_EM_RESTART': '1', 11:19:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:37 INFO - 'PWD': '/builds/slave/test', 11:19:37 INFO - 'SHELL': '/bin/bash', 11:19:37 INFO - 'SHLVL': '1', 11:19:37 INFO - 'TERM': 'linux', 11:19:37 INFO - 'TMOUT': '86400', 11:19:37 INFO - 'USER': 'cltbld', 11:19:37 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477592350.353143-124687251', 11:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:37 INFO - '_': '/tools/buildbot/bin/python'} 11:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:19:37 INFO - Cleaning up... 11:19:37 INFO - Return code: 0 11:19:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7eff26b8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98f60>, '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 0x1a99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477592350.353143-124687251', '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:19:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:19:37 INFO - Using env: {'DISPLAY': ':0', 11:19:37 INFO - 'HOME': '/home/cltbld', 11:19:37 INFO - 'LANG': 'en_US.UTF-8', 11:19:37 INFO - 'LANGUAGE': 'en_US:en', 11:19:37 INFO - 'LOGNAME': 'cltbld', 11:19:37 INFO - 'MAIL': '/var/mail/cltbld', 11:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:37 INFO - 'MOZ_NO_REMOTE': '1', 11:19:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:37 INFO - 'NO_EM_RESTART': '1', 11:19:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:37 INFO - 'PWD': '/builds/slave/test', 11:19:37 INFO - 'SHELL': '/bin/bash', 11:19:37 INFO - 'SHLVL': '1', 11:19:37 INFO - 'TERM': 'linux', 11:19:37 INFO - 'TMOUT': '86400', 11:19:37 INFO - 'USER': 'cltbld', 11:19:37 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477592350.353143-124687251', 11:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:37 INFO - '_': '/tools/buildbot/bin/python'} 11:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:38 INFO - Downloading/unpacking blobuploader==1.2.4 11:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:40 INFO - Downloading blobuploader-1.2.4.tar.gz 11:19:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:19:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:19:40 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:19:40 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:19:40 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:19:40 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:19:40 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:19:40 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:19:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:19:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:19:40 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:19:40 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:19:40 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:19:40 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:19:40 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:19:40 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:19:40 INFO - Downloading docopt-0.6.1.tar.gz 11:19:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:19:40 INFO - Installing collected packages: blobuploader, requests, docopt 11:19:40 INFO - Running setup.py install for blobuploader 11:19:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:19:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:19:40 INFO - Running setup.py install for requests 11:19:41 INFO - Running setup.py install for docopt 11:19:41 INFO - Successfully installed blobuploader requests docopt 11:19:41 INFO - Cleaning up... 11:19:41 INFO - Return code: 0 11:19:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:19:41 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:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:41 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:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:41 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 0x7eff26b8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98f60>, '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 0x1a99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477592350.353143-124687251', '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:19:41 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:19:41 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:19:41 INFO - Using env: {'DISPLAY': ':0', 11:19:41 INFO - 'HOME': '/home/cltbld', 11:19:41 INFO - 'LANG': 'en_US.UTF-8', 11:19:41 INFO - 'LANGUAGE': 'en_US:en', 11:19:41 INFO - 'LOGNAME': 'cltbld', 11:19:41 INFO - 'MAIL': '/var/mail/cltbld', 11:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:41 INFO - 'MOZ_NO_REMOTE': '1', 11:19:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:41 INFO - 'NO_EM_RESTART': '1', 11:19:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:41 INFO - 'PWD': '/builds/slave/test', 11:19:41 INFO - 'SHELL': '/bin/bash', 11:19:41 INFO - 'SHLVL': '1', 11:19:41 INFO - 'TERM': 'linux', 11:19:41 INFO - 'TMOUT': '86400', 11:19:41 INFO - 'USER': 'cltbld', 11:19:41 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477592350.353143-124687251', 11:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:41 INFO - '_': '/tools/buildbot/bin/python'} 11:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:19:41 INFO - Running setup.py (path:/tmp/pip-gJNnZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:19:41 INFO - Running setup.py (path:/tmp/pip-YOXRvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:19:41 INFO - Running setup.py (path:/tmp/pip-pFiuDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:19:41 INFO - Running setup.py (path:/tmp/pip-mmtGBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:19:41 INFO - Running setup.py (path:/tmp/pip-FCnUsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:19:42 INFO - Running setup.py (path:/tmp/pip-HH8bBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:19:42 INFO - Running setup.py (path:/tmp/pip-3N5DQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:19:42 INFO - Running setup.py (path:/tmp/pip-0y_SaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:19:42 INFO - Running setup.py (path:/tmp/pip-3eAYf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:19:42 INFO - Running setup.py (path:/tmp/pip-6l0_dP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:19:42 INFO - Running setup.py (path:/tmp/pip-qgP1FD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:19:42 INFO - Running setup.py (path:/tmp/pip-fsKj0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:19:42 INFO - Running setup.py (path:/tmp/pip-J76XDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:19:42 INFO - Running setup.py (path:/tmp/pip-BWJRH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:19:42 INFO - Running setup.py (path:/tmp/pip-CvpMjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:19:42 INFO - Running setup.py (path:/tmp/pip-n7nMFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:19:42 INFO - Running setup.py (path:/tmp/pip-iiaR6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:19:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:19:42 INFO - Running setup.py install for manifestparser 11:19:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:19:43 INFO - Running setup.py install for mozcrash 11:19:43 INFO - Running setup.py install for mozdebug 11:19:43 INFO - Running setup.py install for mozdevice 11:19:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:19:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:19:43 INFO - Running setup.py install for mozfile 11:19:43 INFO - Running setup.py install for mozhttpd 11:19:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:19:43 INFO - Running setup.py install for mozinfo 11:19:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:19:43 INFO - Running setup.py install for mozInstall 11:19:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:19:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:19:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:19:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:19:43 INFO - Running setup.py install for mozleak 11:19:43 INFO - Running setup.py install for mozlog 11:19:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:19:43 INFO - Running setup.py install for moznetwork 11:19:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:19:44 INFO - Running setup.py install for mozprocess 11:19:44 INFO - Running setup.py install for mozprofile 11:19:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:19:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:19:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:19:44 INFO - Running setup.py install for mozrunner 11:19:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:19:44 INFO - Running setup.py install for mozscreenshot 11:19:44 INFO - Running setup.py install for moztest 11:19:44 INFO - Running setup.py install for mozversion 11:19:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:19:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:19:44 INFO - Cleaning up... 11:19:44 INFO - Return code: 0 11:19:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:19: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:19:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19: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:19:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:44 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 0x7eff26b8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98f60>, '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 0x1a99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477592350.353143-124687251', '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:19:44 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:19:44 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:19:44 INFO - Using env: {'DISPLAY': ':0', 11:19:44 INFO - 'HOME': '/home/cltbld', 11:19:44 INFO - 'LANG': 'en_US.UTF-8', 11:19:44 INFO - 'LANGUAGE': 'en_US:en', 11:19:44 INFO - 'LOGNAME': 'cltbld', 11:19:44 INFO - 'MAIL': '/var/mail/cltbld', 11:19:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:44 INFO - 'MOZ_NO_REMOTE': '1', 11:19:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:44 INFO - 'NO_EM_RESTART': '1', 11:19:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:44 INFO - 'PWD': '/builds/slave/test', 11:19:44 INFO - 'SHELL': '/bin/bash', 11:19:44 INFO - 'SHLVL': '1', 11:19:44 INFO - 'TERM': 'linux', 11:19:44 INFO - 'TMOUT': '86400', 11:19:44 INFO - 'USER': 'cltbld', 11:19:44 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477592350.353143-124687251', 11:19:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:44 INFO - '_': '/tools/buildbot/bin/python'} 11:19:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:19:44 INFO - Running setup.py (path:/tmp/pip-nlFVTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:19:45 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:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:19:45 INFO - Running setup.py (path:/tmp/pip-7KFsox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:19:45 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:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:19:45 INFO - Running setup.py (path:/tmp/pip-faojrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:19:45 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:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:19:45 INFO - Running setup.py (path:/tmp/pip-B1I9C8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:19:45 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:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:19:45 INFO - Running setup.py (path:/tmp/pip-y_U6iM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:19:45 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:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:19:45 INFO - Running setup.py (path:/tmp/pip-B2WgQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:19:45 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:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:19:45 INFO - Running setup.py (path:/tmp/pip-PfJjDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:19:45 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:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:19:45 INFO - Running setup.py (path:/tmp/pip-CP4oWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:19:45 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:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:19:45 INFO - Running setup.py (path:/tmp/pip-ZnNTSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:19:45 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:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:19:45 INFO - Running setup.py (path:/tmp/pip-_Vctfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:19:45 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:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:19:45 INFO - Running setup.py (path:/tmp/pip-k5b3m3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:19:45 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:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:19:45 INFO - Running setup.py (path:/tmp/pip-aJC1Fl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:19:45 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:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:19:45 INFO - Running setup.py (path:/tmp/pip-WuKAiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:19:45 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:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:19:45 INFO - Running setup.py (path:/tmp/pip-CkDKY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:19:45 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:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:19:45 INFO - Running setup.py (path:/tmp/pip-68ZOYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:19:46 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:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:19:46 INFO - Running setup.py (path:/tmp/pip-ge2JlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:19:46 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:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:19:46 INFO - Running setup.py (path:/tmp/pip-DVCbCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:19:46 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:19:46 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:19:46 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:19:46 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:19:46 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:19:46 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:19:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:19:46 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:19:46 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:19:46 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:19:46 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:19:46 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:19:46 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:19:48 INFO - Downloading blessings-1.6.tar.gz 11:19:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:19:48 INFO - Installing collected packages: blessings 11:19:48 INFO - Running setup.py install for blessings 11:19:48 INFO - Successfully installed blessings 11:19:48 INFO - Cleaning up... 11:19:48 INFO - Return code: 0 11:19:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:19:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:19:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:19:48 INFO - Reading from file tmpfile_stdout 11:19:48 INFO - Current package versions: 11:19:48 INFO - argparse == 1.2.1 11:19:48 INFO - blessings == 1.6 11:19:48 INFO - blobuploader == 1.2.4 11:19:48 INFO - docopt == 0.6.1 11:19:48 INFO - functools32 == 3.2.3-2 11:19:48 INFO - jsonschema == 2.5.1 11:19:48 INFO - manifestparser == 1.1 11:19:48 INFO - mozInstall == 1.12 11:19:48 INFO - mozcrash == 0.17 11:19:48 INFO - mozdebug == 0.1 11:19:48 INFO - mozdevice == 0.48 11:19:48 INFO - mozfile == 1.2 11:19:48 INFO - mozhttpd == 0.7 11:19:48 INFO - mozinfo == 0.9 11:19:48 INFO - mozleak == 0.1 11:19:48 INFO - mozlog == 3.4 11:19:48 INFO - moznetwork == 0.27 11:19:48 INFO - mozprocess == 0.23 11:19:48 INFO - mozprofile == 0.28 11:19:48 INFO - mozrunner == 6.12 11:19:48 INFO - mozscreenshot == 0.1 11:19:48 INFO - mozsystemmonitor == 0.3 11:19:48 INFO - moztest == 0.7 11:19:48 INFO - mozversion == 1.4 11:19:48 INFO - psutil == 3.1.1 11:19:48 INFO - requests == 1.2.3 11:19:48 INFO - wsgiref == 0.1.2 11:19:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:48 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 0x7eff26b8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98f60>, '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 0x1a99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477592350.353143-124687251', '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:19:48 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:19:48 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:19:48 INFO - Using env: {'DISPLAY': ':0', 11:19:48 INFO - 'HOME': '/home/cltbld', 11:19:48 INFO - 'LANG': 'en_US.UTF-8', 11:19:48 INFO - 'LANGUAGE': 'en_US:en', 11:19:48 INFO - 'LOGNAME': 'cltbld', 11:19:48 INFO - 'MAIL': '/var/mail/cltbld', 11:19:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:48 INFO - 'MOZ_NO_REMOTE': '1', 11:19:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:48 INFO - 'NO_EM_RESTART': '1', 11:19:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:48 INFO - 'PWD': '/builds/slave/test', 11:19:48 INFO - 'SHELL': '/bin/bash', 11:19:48 INFO - 'SHLVL': '1', 11:19:48 INFO - 'TERM': 'linux', 11:19:48 INFO - 'TMOUT': '86400', 11:19:48 INFO - 'USER': 'cltbld', 11:19:48 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477592350.353143-124687251', 11:19:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:48 INFO - '_': '/tools/buildbot/bin/python'} 11:19:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:48 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:19:48 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:19:48 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:19:48 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:19:48 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:19:48 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:19:48 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:19:48 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:19:48 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:19:48 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:19:48 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:19:48 INFO - Cleaning up... 11:19:48 INFO - Return code: 0 11:19:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:48 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 0x7eff26b8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a98f60>, '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 0x1a99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477592350.353143-124687251', '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:19:48 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:19:48 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:19:48 INFO - Using env: {'DISPLAY': ':0', 11:19:48 INFO - 'HOME': '/home/cltbld', 11:19:48 INFO - 'LANG': 'en_US.UTF-8', 11:19:48 INFO - 'LANGUAGE': 'en_US:en', 11:19:48 INFO - 'LOGNAME': 'cltbld', 11:19:48 INFO - 'MAIL': '/var/mail/cltbld', 11:19:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:48 INFO - 'MOZ_NO_REMOTE': '1', 11:19:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:48 INFO - 'NO_EM_RESTART': '1', 11:19:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:48 INFO - 'PWD': '/builds/slave/test', 11:19:48 INFO - 'SHELL': '/bin/bash', 11:19:48 INFO - 'SHLVL': '1', 11:19:48 INFO - 'TERM': 'linux', 11:19:48 INFO - 'TMOUT': '86400', 11:19:48 INFO - 'USER': 'cltbld', 11:19:48 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477592350.353143-124687251', 11:19:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:48 INFO - '_': '/tools/buildbot/bin/python'} 11:19:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:19:48 INFO - Cleaning up... 11:19:49 INFO - Return code: 0 11:19:49 INFO - Running post-action listener: _resource_record_post_action 11:19:49 INFO - Running post-action listener: _start_resource_monitoring 11:19:49 INFO - Starting resource monitoring. 11:19:49 INFO - [mozharness: 2016-10-27 18:19:49.048105Z] Finished create-virtualenv step (success) 11:19:49 INFO - [mozharness: 2016-10-27 18:19:49.048600Z] Running install step. 11:19:49 INFO - Running pre-action listener: _resource_record_pre_action 11:19:49 INFO - Running main action method: install 11:19:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:19:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:19:49 INFO - Reading from file tmpfile_stdout 11:19:49 INFO - Detecting whether we're running mozinstall >=1.0... 11:19:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:19:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:19:49 INFO - Reading from file tmpfile_stdout 11:19:49 INFO - Output received: 11:19:49 INFO - Usage: mozinstall [options] installer 11:19:49 INFO - Options: 11:19:49 INFO - -h, --help show this help message and exit 11:19:49 INFO - -d DEST, --destination=DEST 11:19:49 INFO - Directory to install application into. [default: 11:19:49 INFO - "/builds/slave/test"] 11:19:49 INFO - --app=APP Application being installed. [default: firefox] 11:19:49 INFO - mkdir: /builds/slave/test/build/application 11:19:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:19:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:20:05 INFO - Reading from file tmpfile_stdout 11:20:05 INFO - Output received: 11:20:05 INFO - /builds/slave/test/build/application/firefox/firefox 11:20:05 INFO - Running post-action listener: _resource_record_post_action 11:20:05 INFO - [mozharness: 2016-10-27 18:20:05.319168Z] Finished install step (success) 11:20:05 INFO - [mozharness: 2016-10-27 18:20:05.319410Z] Running run-tests step. 11:20:05 INFO - Running pre-action listener: _resource_record_pre_action 11:20:05 INFO - Running main action method: run_tests 11:20:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:20:05 INFO - Python 2.7.3 11:20:05 INFO - Return code: 0 11:20:05 INFO - grabbing minidump binary from tooltool 11:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:05 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 0x1a98f60>, '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 0x1a99d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:20:05 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:20:05 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:20:05 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:20:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:20:05 INFO - Return code: 0 11:20:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:20:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:20:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:20:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:20:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:20:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S6Nj6k24QsyOG113-d7gww/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S6Nj6k24QsyOG113-d7gww/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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:20:05 INFO - Using env: {'DISPLAY': ':0', 11:20:05 INFO - 'HOME': '/home/cltbld', 11:20:05 INFO - 'LANG': 'en_US.UTF-8', 11:20:05 INFO - 'LANGUAGE': 'en_US:en', 11:20:05 INFO - 'LOGNAME': 'cltbld', 11:20:05 INFO - 'MAIL': '/var/mail/cltbld', 11:20:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:20:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:05 INFO - 'MOZ_NO_REMOTE': '1', 11:20:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:20:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:05 INFO - 'NO_EM_RESTART': '1', 11:20:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:05 INFO - 'PWD': '/builds/slave/test', 11:20:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:20:05 INFO - 'SHELL': '/bin/bash', 11:20:05 INFO - 'SHLVL': '1', 11:20:05 INFO - 'TERM': 'linux', 11:20:05 INFO - 'TMOUT': '86400', 11:20:05 INFO - 'USER': 'cltbld', 11:20:05 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477592350.353143-124687251', 11:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:05 INFO - '_': '/tools/buildbot/bin/python'} 11:20:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S6Nj6k24QsyOG113-d7gww/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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:20:05 INFO - mozversion application_buildid: 20161027080634 11:20:05 INFO - mozversion application_changeset: 7b654728d154b6f60ae94f6498d6a2470e76f994 11:20:05 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:20:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:20:05 INFO - mozversion application_name: Firefox 11:20:05 INFO - mozversion application_remotingname: firefox-dev 11:20:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:20:05 INFO - mozversion application_vendor: Mozilla 11:20:05 INFO - mozversion application_version: 51.0a2 11:20:05 INFO - mozversion platform_buildid: 20161027080634 11:20:05 INFO - mozversion platform_changeset: 7b654728d154b6f60ae94f6498d6a2470e76f994 11:20:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:20:05 INFO - mozversion platform_version: 51.0a2 11:20:05 INFO - using testdate: 1477592405 11:20:05 INFO - actual date: 1477592405 11:20:05 INFO - starting webserver on 'localhost:44230' 11:20:05 INFO - SUITE-START | Running 2 tests 11:20:05 INFO - TEST-START | dromaeo_css 11:20:05 INFO - operating with platform_type : linux_ 11:20:05 INFO - Initialising browser for dromaeo_css test... 11:20:05 INFO - TEST-INFO | started process 13359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnrASbA/profile http://localhost:44230/getInfo.html) 11:20:10 INFO - PROCESS | 13359 | __metrics Screen width/height:1600/1200 11:20:10 INFO - PROCESS | 13359 | colorDepth:24 11:20:10 INFO - PROCESS | 13359 | Browser inner width/height: 1024/697 11:20:10 INFO - PROCESS | 13359 | __metrics 11:20:10 INFO - PROCESS | 13359 | 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:20:10 INFO - PROCESS | 13359 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:20:11 INFO - PROCESS | 13359 | console.error: PushService: 11:20:11 INFO - PROCESS | 13359 | stateChangeProcessEnqueue: Error transitioning state 11:20:11 INFO - PROCESS | 13359 | UnknownError 11:20:11 INFO - TEST-INFO | 13359: exit 0 11:20:11 INFO - Browser initialized. 11:20:11 INFO - Running cycle 1/1 for dromaeo_css test... 11:20:11 INFO - TEST-INFO | started process 13453 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnrASbA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:20:23 INFO - PROCESS | 13453 | RSS: Main: 145125376 11:20:23 INFO - PROCESS | 13453 | 11:21:15 INFO - PROCESS | 13453 | 1477592475009 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:23:24 INFO - PROCESS | 13453 | Cycle 1(1): loaded http://localhost:44230/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44230/tests/dromaeo/cssquery-ext.html) 11:23:25 INFO - PROCESS | 13453 | RSS: Main: 243892224 11:23:25 INFO - PROCESS | 13453 | 11:26:27 INFO - PROCESS | 13453 | Cycle 1(1): loaded http://localhost:44230/tests/dromaeo/cssquery-ext.html (next: http://localhost:44230/tests/dromaeo/cssquery-jquery.html) 11:26:28 INFO - PROCESS | 13453 | RSS: Main: 226701312 11:26:28 INFO - PROCESS | 13453 | 11:29:30 INFO - PROCESS | 13453 | Cycle 1(1): loaded http://localhost:44230/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44230/tests/dromaeo/cssquery-mootools.html) 11:29:30 INFO - PROCESS | 13453 | RSS: Main: 222248960 11:29:30 INFO - PROCESS | 13453 | 11:32:32 INFO - PROCESS | 13453 | Cycle 1(1): loaded http://localhost:44230/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44230/tests/dromaeo/cssquery-prototype.html) 11:32:33 INFO - PROCESS | 13453 | RSS: Main: 174534656 11:32:33 INFO - PROCESS | 13453 | 11:35:36 INFO - PROCESS | 13453 | Cycle 1(1): loaded http://localhost:44230/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44230/tests/dromaeo/cssquery-yui.html) 11:35:36 INFO - PROCESS | 13453 | RSS: Main: 174727168 11:35:36 INFO - PROCESS | 13453 | 11:38:39 INFO - PROCESS | 13453 | Cycle 1(1): loaded http://localhost:44230/tests/dromaeo/cssquery-yui.html (next: http://localhost:44230/tests/dromaeo/cssquery-dojo.html) 11:38:39 INFO - PROCESS | 13453 | RSS: Main: 242352128 11:38:39 INFO - PROCESS | 13453 | 11:38:39 INFO - PROCESS | 13453 | __start_tp_report 11:38:39 INFO - PROCESS | 13453 | _x_x_mozilla_page_load 11:38:39 INFO - PROCESS | 13453 | _x_x_mozilla_page_load_details 11:38:39 INFO - PROCESS | 13453 | |i|pagename|runs| 11:38:39 INFO - PROCESS | 13453 | |0;dojo.html;3115.361350923061;3154.3218208085264;3164.7626428017907;3178.4278829810623;3210.1011716719313;5464.781408743651;5551.805686800963;5555.055640541108;5568.025595520783;5572.832815015546;5634.746436410361;5705.714714264281;5710.971445142768;5712.11462223356;5727.713614319277;5100.387953445583;5120.078385890538;5138.845834624967;5200.791968321281;5205.739713014353;4952.801887924478;5181.974090129563;5204.193350030751;5209.244659524366;5211.557017653504;4913.606911447076;5047.596192304607;5054.1660625996665;5084.389873215219;5093.236014597803;5088.4911508849;5116.360454943114;5121.769520371592;5187.429382767892;5199.168133098686;5006.374203224597;5087.414947281073;5153.458886816868;5174.042802081627;5197.986392653434;5340.412554618989;5389.730513474311;5468.316460442445;5509.283793106871;5560.916586251209;5932.080527518198;5937.139114828326;5972.761089556412;6044.2746870375395;6046.848828779316;6028.547858910555;6071.4535691787505;6075.05836595324;6082.878342433127;6084.908726369108;5418.458154184589;5440.238366628715;5489.39616642169;5504.394516603171;5512.6968016759465;6168.352323006109;6208.4722798561725;6211;6211.689415529206;6215.471684906744;5911.674857882772;5945.137954996588;5945.346011938684;5957.880842383215;5957.880842383215;5782.537397008229;5832.766689332379;5839.5036421904615;5886.852828679317;5910.881782364415;5950.166976623276;5950.642961422329;5953.315368732565;5955.910661340084;5978.372270911578;5914.674692891932;5954.46409823118;5983.102534619842;5983.6708981005595;6005.849853753691;4443.37792709021;4466.977665111719;4545.568171023748;4593.356930029799;4596.057808149321;4072.3891416287793;4112.115895082572;4125.876223713293;4126.195391898551;4143.7306575072525;5683.857903552444;5696.3733989261145;5703.572232082611;5705.258316418922;5705.657660540381;5787.247657804459;5843.357230704619;5885.61743486672;6063.181470501426;6072.423119803611;5582.8325150245555;5657.179708942181;5657.8019769307875;5678.602497825113;5694.629849059881;5018.2974383586325;5041.117804384291;5053.974730126326;5055.87360315995;5090.821821236313;5943.821685349447;6076.756929722762;6144.2319710036245;6153.1693221415435;6158.630482171084;5959.582829201914;6013.849653758691;6039.4262545058145;6100.877982440237;6133.4786543142545;6215.098810672517;6251.749930002931;6256.843578910563;6265.091561723433;6269.96865015672;5621.690807005654;5974.641521508724;5977.163197152489;5981.475948610661;6021.608595441282;5680;5867.559933004956;5905.970470147622;5910.231669882888;6029.366916473882;5781.132830075522;5830.4461076197695;5832.125181222681;5836.241288632451;5838.766449341979;5829.358770535153;5830.708464576839;5833.125031245348;5837.591368604157;5844.883102338014;5554.921583122857;5707.5433965281845;5806.303243610625;5835;5865.149553314831;5975.7012149391485;5977.22296101504;5983.730732117152;5983.820485385445;5985.102234664835;5569.554435645057;5831.300243970581;5832.650040997553;5837.241158649348;5840.853978650568 11:38:39 INFO - PROCESS | 13453 | |1;ext.html;580.1500801326057;611.260374946315;638.7636574467444;648.6562122075298;649.6459429610861;37370;45966.31050534241;46648.76675616625;46726.29910551345;51577.2263416049;41933.7903310483;42402.7879860601;42474.7876260619;42556.36165457521;42629.57370426295;8327.875081873777;9177.724668259947;9296.209822165125;9335.719928402124;9339.533023348838;8166.918330816705;11148.21962462628;11432.2569033013;11435.256708313933;11438.256513326607;11297.435128243596;11354.148438867118;11357.091432685365;11365.261258018243;11375.431228438545;10837.458127093614;10871.45642717865;10938.835917461245;10942.398168100752;10952.507137178845;10954.507047182897;10959.726006849813;11016.889831101667;11033.227674062819;11037.558497660084;44837.10325793466;44844.32733509;44911.550884491066;45230.54769452296;45265;3784.2620688965662;3901.8634347797692;3913.2760439318818;3966.5037549171525;3981.243563722883;33828.49257261143;35085.82457087724;36135.27729445396;36140.09649758751;36292.27415451703;4050.4936882889638;4070.796460177009;4093.4269202311702;4102.384642303648;4119.670426365884;398099;404844;405794.9130763041;407431;407704;71955.28044719486;72930;73050.63474682592;73066.26933730594;73188.26811731921;42356.57643423588;43195.92010199707;43376;45329.54670453319;45537.316940245924;18662.253509859725;18761.06194690287;18794;18804.811951880307;18811.059447027594;13325.73348533024;13487.460501580023;13516.864831351757;13602.659933501543;14108.153510789385;21966;22946.7705322948;23038.42403939915;23064.192753253556;23066.19268325634;7961;8103.6758529658155;8181.754547363588;8212.671493140208;8438.662453501915;1029.4235228272191;1040.9791804164026;1104.608193675974;1119.9328040317444;1127.1208457403238;34708.82645586807;35054.91703702949;35148.648513514534;35310.823445882605;35321.64678353183;1087.8477013218155;1132.9433528323716;1160.1762748448696;1161.3322339654565;1208.504513149622;17976.820231797778;18433;18440.17019234111;18441.631167376578;18448.723269150974;598906;607566;611745;614088;614260;64013.35986640167;64408.35591644117;64604;64678;64773.352266477676;1332.6934804994905;1365.6722386627139;1383.384393944685;1412.25150670145;1452.259347732643;31563.368732625677;35351.8102372035;35717.82141089278;35865.58226829889;35918.640813591526;53300.46699532955;53708.19437708359;54116.18825717696;54138.45861541334;54158.72920635372;409300;410020;410142;410692;410803;32434;33084.834575826964;33357;33838.154046149044;34465.65534344625;51838.22242666288;52258;52369.3341466109;53051.20423193578;53314;38510.2297954045;38619;38696.41955370728;39413.605863941;39904.60095399009;37776.05559860916;37807;38118.23763524769;39802.60197397989;39823.60176398199;43046.56953430425;43426.782866085465;44088;44642.3303650452;46679.29981050219;37975.810120949216;39727.40408893926;40938.795306023276;41112.58887411088;41404.58595414007;28827.388417281745;29830.403391931606;29969.74956607984;29981.400371992873;29998 11:38:39 INFO - PROCESS | 13453 | |2;jquery.html;397.76929380959047;416.5418040155829;417.5135966598912;420.5941266677655;440.2625602116454;14791.704165916675;16398.836011639894;19894.00529973501;20578.588428231425;21596;19501.707474387895;19686;19947.800521994814;20104.09531571079;20116.29592964243;5987.191729116579;6055.788047418341;6098.32918378978;6124.571280010401;6162.661053642048;6020.518358531329;6108.480779133779;6113.174721412619;6115.541334399915;6121.418465245817;5715.228444160048;5943.108533719934;5985.6408615483215;6093.177421048146;6105.358937311585;5791.276090488689;5907.5864689471755;6001.129836173752;6038.33578306386;6040.184575082373;5781.161731548944;5785.595008349417;5790.36306006339;5790.652560846321;5791.305043394777;14484.92757536216;14511.419543218259;14567.344469498898;14632;14663.41346346145;2405.7594240575804;2421.3583400398907;2514.459391230894;2531.4304281536693;2585.5475291824046;10575.894241057567;10702.946485267601;10772.461376931122;10778.676639700743;13830.446782128703;1929.1415320182525;2022.4337185588058;2064.2465500092508;2073.2536286936693;2081.8646787958733;83038.58480707619;87968;88651.55674221652;89900.55049724775;93432;11112.888871111347;11298.830517542243;11392.715182120513;11454.59908903201;11474.713132171762;16892.746608800877;16898.07060611678;16933.238004289837;16934.153292335333;16934.576635583962;8595.226429621363;8790.692325768567;8843.867341989875;8927.776805579913;9003.594838232295;8550.1449855014;8602.053774084845;8605.182507661762;8768.167024132697;8818.250448711931;4984.177610694267;5008.4240312364545;5046.62150338726;5059.620528460307;5132.871678208;2061.5361543652557;2074.1392322186125;2106.6734656128324;2128.7445506539007;2136.4979229880964;929.972100836976;963.8843338799248;971.8056388722284;1056.5562463765236;1121.5738019552518;20270.594588108157;20926.895365523378;21024.89487552583;21107.788922110583;21147.25984590532;1002.9749256268506;1009.7475631092227;1033.8190816607064;1061.135174832509;1074.4412905289362;10772.274457689296;11054.22620416563;11162.274452160584;11513.654590362303;11595.420228988516;412032;414966;417247;528050;534924;59986.70006649939;60951.80109592873;100743.955362677;102189;105001.47499262454;981.504340308154;985;1019.9439030853374;1020.4336593190702;1025.8307379282335;18388.540286492946;18862.339818106302;18989.240430383183;19207.135678894763;19469.902650486656;31237.375252494367;31823.840880795447;31919;42481.78759106308;45565.77217113893;62727;63348.68325658527;63523.682381587794;63568.364316356245;63975.3602463988;9362.535861731203;9520.809898762654;9522.190613797904;9527.809443810946;9640.42157470554;13574;13838.37727302294;14167.43330266819;14332.472179053446;14665.92667036658;12187.695307617381;12462;12494.500219991098;12796.488140474277;13080.215187088805;11575.189736718687;11820.290782553075;12685;12698.746025079632;12792.74414511686;12379.62861114168;12503.56237531682;12602.810957835456;12617.369131543202;12980.935095324463;8069.919300807152;8252.133525979685;8922.197002269826;9350.111739384747;9403.43579385239;11119.499622517167;11174.35694974033;12584.937075314565;12845.486180552673;12917 11:38:39 INFO - PROCESS | 13453 | |3;mootools.html;1314.3099872566895;1444.768836986082;1481.6592183797727;1657.825928277531;1837.2926423327024;7986.800329991753;8877.955610221949;9199.862002069975;9229.861552076716;9491.430514169155;9258.490783006931;9336.719898403042;9340.486273254985;9344.252459803216;9346.859797103049;2492.6136448850457;2502.887370068351;2506.0602274147195;2511.8744062796877;2516.811239157061;2420.249722585995;2491.402063504764;2491.7632824881607;2492.538880307149;2492.675952126221;2470.3206618179966;2474.1464194852747;2522.445062086338;2528.633348164515;2528.835625684334;2428.5142971405703;2444.6699695541142;2455.594826853567;2462.7660372264604;2463.8768061596847;2415.9879200603887;2433.829631925766;2441.5483135619966;2442.68245128134;2464.039024780337;8942.68700595476;8989.325800564984;9024.819503609957;9050.683226087056;9145.725628231165;5440.891182176374;5578;5586.217929489874;5586.608937374385;5602.327720673505;3412.351653185887;3474.4614584739406;3496.4056110461283;3519.260955199411;3547.9822600886832;1208.9818652720217;1213.4236237787068;1224.571002238249;1251.2054845173288;1263.1663102352404;12791.424385902657;12804.80792788109;12812.80780788289;12883.291418971952;12907.677308067374;4742.188940206975;4763.2140696784645;4810.278458231293;4897.534734200245;4961.50384961501;9690.612375504901;9723.854142187873;9807.656732014346;9810.362326448758;9840.655577054911;5540.085885828793;5550.16747487872;5550.694711790809;5555.111182210827;5567.944320556742;4539.387182730356;4665.323528088408;5043.571296439771;5142.717150556755;5221.269022336875;4071.5521292657786;4115.9588404115575;4192.874213773592;4218.6625069994325;4234.6823988201;1268.6828292926768;1277.303869391184;1280.0975312404732;1285.6207418811287;1302.602706174607;1034.6275340877278;1035.8394448860438;1043.2801367056707;1047.2983101322131;1054.082947835388;6146.938530614726;6295.7737350371335;6318.115463835067;6322.083297921776;6372.522060845455;500.37952938356904;500.79558661419344;506.8656805946427;509.78588992623185;517.6842126302952;4343.782810859444;4455.1535208310315;4484.977575112103;4596.839110631178;4607.792649330788;11121.888781112248;11322.94338528302;11397.544098236143;11399.715007124889;11399.772004559862;10940.56237750497;11328.32030078198;11331.60339388134;11334.60328888485;11357.148213883827;8491.320694344438;8709.651613935499;8715.651373945098;8716.564171791386;8721;6441.194850643669;6516.57642253252;6605.174353205849;6679.131712877489;6758.459323254227;10143.492825358555;10399.220058495794;10582;10656.840147397641;10712.410817405118;10661.840072398765;10893.618723344645;10894.400807955639;10969.23215374916;10999.175061870232;7316.122065351979;7773.650185741768;7945.721899733481;8046.557439340892;8228.547429891414;8813.427127236966;8971.461712297283;8997.730068097968;9004.819903602021;9017.504037278013;7855.33229675484;7972;8004.51972881629;8068.919310807051;8230.670773169006;8117.350611951148;8157.306628936607;8170.714025009096;8256.711015114442;8304.916950830415;7198.964005179941;7214.170370407471;7269.963650181715;7280.1991780903;7281.854362912606;5129.7691603877165;5296.576273898156;5320.733963301742;5327.067763141512;5341.225522299167;5472.124460086367;5594.4125866785025;5649.067903795828;5712.600117991867;5727.828165155052 11:38:39 INFO - PROCESS | 13453 | |4;prototype.html;350.97894126352423;355.92525569630374;356.3959089343562;356.6023883370043;359.7212160575552;5463.617546771728;5497.917531237024;5522.254495643087;5533;5539.086050801613;5382.111951528003;5445.264889239951;5468;5471.699056551888;5478.616496845212;4119.382092686106;4145.5647157048525;4182.665386769051;4268.701190916637;4358.455193100863;4298.527162012176;4303.591158839905;4314;4318.784060796947;4323.718958267703;4212.136512015045;4262.360645903123;4266.530681625019;4274.230638485072;4315.4605674290715;3992.920141597166;4050.250703619825;4219.261629214875;4225.732280315893;4260.723053001545;3770.245950809849;3776.4524143998965;3779.225258821935;3783.9432408513894;3820.541535015816;5264.341507538668;5295.841124766224;5297.284866543006;5309.495597918191;5315.920261196085;4809.591184749265;4859.635527335428;4892.266160075981;4951.950480495185;4978.701277923336;5585.385607583163;5602.915956260659;5620.859478513029;5622.634528755618;5631.521320687746;4197.265478541273;4207.305794543927;4210.179015092058;4215.810288537024;4216.156768646283;5787.276590426197;5820.767169313265;5842.766289348421;5861.062230043172;5923.229980102602;4280.79539037396;4285.335772955197;4297.82808687649;4301.257990513847;4309.310510318334;4371.147626212922;4377.971176773456;4381.496127945264;4401.405810215644;4404.427424434803;4834.613230941516;4903.681260718042;4935.87660308488;4951.5048495150195;4981.701097934136;5711.628744131618;5720.11338242573;5720.599558030981;5731.254936858182;5746.856328591819;1504.50351384043;1512.7125846089207;1515.4847351900407;1526.2521364531522;1527.4424834935392;946.9810603787886;947.6067432015774;1002.4636819301638;1008.2690049713899;1017.9185665146771;5330.38700549434;5389.730513474311;5523.226748255248;5523.8066667666435;5533.695646739468;5833.854153646108;5846.853828654318;5847.707614619252;5855.833341663527;5858.56060795442;5333.663121444472;5481.2874326338115;5531.751071201725;5545.306836645419;5545.72271386429;3049.054793014173;3066.861991210401;3084.6606873243927;3090.5827713258873;3095.8297293649066;5859.129026776849;5999.520038396918;6000.939990600125;6012.338642749294;6043.607165534227;5854.2974843018255;5882.941170588325;5895.823125306248;5898.490398213056;5899.616524925952;5904.225014243299;5922.3485416605;5949.970250148722;5964.642121472725;5976.402359763989;5535.39110697831;5771.797987070432;5778.219940308173;5784.392638773036;5810.54736315921;5724.198612194379;5743.420559346213;5745;5755.223044888887;5759.424057594207;5806.303243610793;5949.3455719871645;5994.15277743086;5997.860406522746;5999.880002400015;4104.794760262034;4132.111596006873;4141.378793181047;4167.229062623424;4179.164167166518;5848.970755146197;5864.589478736448;5883.146808755228;5888.67504811414;5922.496587789914;5539.642787517084;5652.463016013637;5681.9431805681415;5777.9133313001175;5789.9710501447225;5658.094704847204;5661.886762264814;5670.69573997991;5676.4323567642905;5688.971555142198;5616.915746263891;5624.29696287964;5688.971555142198;5707.1737044145475;5719.599628025998;5278.9472105278455;5497.945020549743;5628.971855140698;5689.829305120853;5701.173329867229;5568.888622227614;5572;5581.176893827741;5591.888162236651;5594.328680558359 11:38:39 INFO - PROCESS | 13453 | |5;yui.html;777.8444311137774;794.0312818361599;802.1897883138029;802.2779498451389;815.8572249856276;14471.638209044779;15350.539483815475;15478.69042619147;15553.922230388845;15803;13859.93070034651;13997.930010349934;14015.369308381121;14024.228667423287;14047.648808779786;725.4522835259372;728.4281838756577;856.8971723393202;872.3806097670662;874.6851133591902;848.5714714069417;859.5873980489368;864.2653744317342;879.4503435352905;881.8809460722816;919.9172074513292;924.3760461688368;924.4684306523742;924.7456949338952;924.856647219682;760.0992823504165;775.0737868247446;920.5075284722675;921.1525396635078;922.0871337376017;645.699749616426;663.4460225711537;664.6577012838392;668.0513670587777;668.2248591633681;14705.779413308808;14727.116373017654;14733.484328048467;14736.705265894621;14760.778588321184;13741.931290343584;13792.517261895886;14124.152550846982;14173.929130354281;14676.633084172874;13235.914985769718;13294.601161965156;13407.932960335233;13689.178649280975;13811.654708632264;4433.2685106957315;4458.71018383804;4489.438820147481;4653.464851542082;4654.418197725285;84246.15753842445;88525;88558.11441885564;88693.55653221822;89484;11402.429878506042;11500.194986351042;11607.419629018515;11678.416079196006;11763.941180294214;22021.77978220197;22043.228487002878;22177.334679959626;22184.889075554518;22879.771202287764;8431.957840210882;8553.588657871505;8671.56642167889;8830.646774128963;8899.243564297107;4814.807407703723;4816.759162041884;4821.662483626113;4848.5636292733825;5032.32063671407;3528.6471352865024;3660.3228402745576;3662.8717994870585;3664.688501477351;3669.027707657473;610.3408319015541;611.2267981004034;614.9446549810539;632.4687262699263;638.2341190571241;679.1985457160598;705.7917914215319;707.6673963237271;709.7090193020837;711.1146622454974;9216.216621587106;9274.258059355236;9671.468069256118;9684.41893486379;9731.805363892683;676.1615596660205;682.7303215229956;693.4868197533789;703.3388614702163;710.7476845719798;4762.190427627312;4838.225883858566;4871.878203044952;4932.4327702314695;4939.234418665113;82966.17033829704;121326;132820;136198.59503512294;137051;87871.56064219766;89827.55086224657;113611;117627;117771.41114294545;86115.56942215249;88799;89058.55470722605;92557.5372123135;95167.52416237874;10379;10601.893981060399;10683.5192416343;10761.354318740901;10999.780004399707;53351;54443.45556544384;55004;56218.43781562296;56931.43068569261;50560.70843161609;52113.47886521238;53702.194467083806;60843.69578152081;65533.34466655272;13628.523001694894;14275.928620356832;14413.351399186851;14537.636559086108;14682.77975830342;15603.141827199614;15840.920795395949;16136.273867676218;16167.434139805051;16405;11237.662870113909;14620.780688289897;14775.9337964651;14785.630359241106;15837.841621583637;14985.700285994437;15199.392024318904;15200.163990980602;15458.14980176056;15519.301631426388;14931.10413375201;15048.548543543711;15334.846651533342;15618.84381156174;15871.206439677739;12023.879761202275;12072.75854482888;12294.474745315256;12514.812277816021;12715.55495557651;12374.257544546996;12392.442340094898;12429.50845898498;12631.115821892747;12732.172408793398 11:38:39 INFO - PROCESS | 13453 | __end_tp_report 11:38:39 INFO - PROCESS | 13453 | __start_cc_report 11:38:39 INFO - PROCESS | 13453 | _x_x_mozilla_cycle_collect,958 11:38:39 INFO - PROCESS | 13453 | __end_cc_report 11:38:39 INFO - PROCESS | 13453 | __startTimestamp1477593519598__endTimestamp 11:38:39 INFO - PROCESS | 13453 | 11:38:39 INFO - PROCESS | 13453 | ------- Summary: start ------- 11:38:39 INFO - PROCESS | 13453 | Number of tests: 6 11:38:39 INFO - PROCESS | 13453 | 11:38:39 INFO - PROCESS | 13453 | [#0] dojo.html Cycles:165 Average:5553.57 Median:5787.25 stddev:641.50 (11.1%) stddev-sans-first:614.29 11:38:39 INFO - PROCESS | 13453 | Values: 3115.4 3154.3 3164.8 3178.4 3210.1 5464.8 5551.8 5555.1 5568.0 5572.8 5634.7 5705.7 5711.0 5712.1 5727.7 5100.4 5120.1 5138.8 5200.8 5205.7 4952.8 5182.0 5204.2 5209.2 5211.6 4913.6 5047.6 5054.2 5084.4 5093.2 5088.5 5116.4 5121.8 5187.4 5199.2 5006.4 5087.4 5153.5 5174.0 5198.0 5340.4 5389.7 5468.3 5509.3 5560.9 5932.1 5937.1 5972.8 6044.3 6046.8 6028.5 6071.5 6075.1 6082.9 6084.9 5418.5 5440.2 5489.4 5504.4 5512.7 6168.4 6208.5 6211.0 6211.7 6215.5 5911.7 5945.1 5945.3 5957.9 5957.9 5782.5 5832.8 5839.5 5886.9 5910.9 5950.2 5950.6 5953.3 5955.9 5978.4 5914.7 5954.5 5983.1 5983.7 6005.8 4443.4 4467.0 4545.6 4593.4 4596.1 4072.4 4112.1 4125.9 4126.2 4143.7 5683.9 5696.4 5703.6 5705.3 5705.7 5787.2 5843.4 5885.6 6063.2 6072.4 5582.8 5657.2 5657.8 5678.6 5694.6 5018.3 5041.1 5054.0 5055.9 5090.8 5943.8 6076.8 6144.2 6153.2 6158.6 5959.6 6013.8 6039.4 6100.9 6133.5 6215.1 6251.7 6256.8 6265.1 6270.0 5621.7 5974.6 5977.2 5981.5 6021.6 5680.0 5867.6 5906.0 5910.2 6029.4 5781.1 5830.4 5832.1 5836.2 5838.8 5829.4 5830.7 5833.1 5837.6 5844.9 5554.9 5707.5 5806.3 5835.0 5865.1 5975.7 5977.2 5983.7 5983.8 5985.1 5569.6 5831.3 5832.7 5837.2 5840.9 11:38:39 INFO - PROCESS | 13453 | 11:38:39 INFO - PROCESS | 13453 | [#1] ext.html Cycles:180 Average:64530.26 Median:21690.05 stddev:128472.67 (592.3%) stddev-sans-first:128743.34 11:38:39 INFO - PROCESS | 13453 | Values: 580.2 611.3 638.8 648.7 649.6 37370.0 45966.3 46648.8 46726.3 51577.2 41933.8 42402.8 42474.8 42556.4 42629.6 8327.9 9177.7 9296.2 9335.7 9339.5 8166.9 11148.2 11432.3 11435.3 11438.3 11297.4 11354.1 11357.1 11365.3 11375.4 10837.5 10871.5 10938.8 10942.4 10952.5 10954.5 10959.7 11016.9 11033.2 11037.6 44837.1 44844.3 44911.6 45230.5 45265.0 3784.3 3901.9 3913.3 3966.5 3981.2 33828.5 35085.8 36135.3 36140.1 36292.3 4050.5 4070.8 4093.4 4102.4 4119.7 398099.0 404844.0 405794.9 407431.0 407704.0 71955.3 72930.0 73050.6 73066.3 73188.3 42356.6 43195.9 43376.0 45329.5 45537.3 18662.3 18761.1 18794.0 18804.8 18811.1 13325.7 13487.5 13516.9 13602.7 14108.2 21966.0 22946.8 23038.4 23064.2 23066.2 7961.0 8103.7 8181.8 8212.7 8438.7 1029.4 1041.0 1104.6 1119.9 1127.1 34708.8 35054.9 35148.6 35310.8 35321.6 1087.8 1132.9 1160.2 1161.3 1208.5 17976.8 18433.0 18440.2 18441.6 18448.7 598906.0 607566.0 611745.0 614088.0 614260.0 64013.4 64408.4 64604.0 64678.0 64773.4 1332.7 1365.7 1383.4 1412.3 1452.3 31563.4 35351.8 35717.8 35865.6 35918.6 53300.5 53708.2 54116.2 54138.5 54158.7 409300.0 410020.0 410142.0 410692.0 410803.0 32434.0 33084.8 33357.0 33838.2 34465.7 51838.2 52258.0 52369.3 53051.2 53314.0 38510.2 38619.0 38696.4 39413.6 39904.6 37776.1 37807.0 38118.2 39802.6 39823.6 43046.6 43426.8 44088.0 44642.3 46679.3 37975.8 39727.4 40938.8 41112.6 41404.6 28827.4 29830.4 29969.7 29981.4 29998.0 11:38:39 INFO - PROCESS | 13453 | 11:38:39 INFO - PROCESS | 13453 | [#2] jquery.html Cycles:180 Average:28452.04 Median:2132.62 stddev:76935.93 (3607.6%) stddev-sans-first:77122.91 11:38:39 INFO - PROCESS | 13453 | Values: 397.8 416.5 417.5 420.6 440.3 14791.7 16398.8 19894.0 20578.6 21596.0 19501.7 19686.0 19947.8 20104.1 20116.3 5987.2 6055.8 6098.3 6124.6 6162.7 6020.5 6108.5 6113.2 6115.5 6121.4 5715.2 5943.1 5985.6 6093.2 6105.4 5791.3 5907.6 6001.1 6038.3 6040.2 5781.2 5785.6 5790.4 5790.7 5791.3 14484.9 14511.4 14567.3 14632.0 14663.4 2405.8 2421.4 2514.5 2531.4 2585.5 10575.9 10702.9 10772.5 10778.7 13830.4 1929.1 2022.4 2064.2 2073.3 2081.9 83038.6 87968.0 88651.6 89900.6 93432.0 11112.9 11298.8 11392.7 11454.6 11474.7 16892.7 16898.1 16933.2 16934.2 16934.6 8595.2 8790.7 8843.9 8927.8 9003.6 8550.1 8602.1 8605.2 8768.2 8818.3 4984.2 5008.4 5046.6 5059.6 5132.9 2061.5 2074.1 2106.7 2128.7 2136.5 930.0 963.9 971.8 1056.6 1121.6 20270.6 20926.9 21024.9 21107.8 21147.3 1003.0 1009.7 1033.8 1061.1 1074.4 10772.3 11054.2 11162.3 11513.7 11595.4 412032.0 414966.0 417247.0 528050.0 534924.0 59986.7 60951.8 100744.0 102189.0 105001.5 981.5 985.0 1019.9 1020.4 1025.8 18388.5 18862.3 18989.2 19207.1 19469.9 31237.4 31823.8 31919.0 42481.8 45565.8 62727.0 63348.7 63523.7 63568.4 63975.4 9362.5 9520.8 9522.2 9527.8 9640.4 13574.0 13838.4 14167.4 14332.5 14665.9 12187.7 12462.0 12494.5 12796.5 13080.2 11575.2 11820.3 12685.0 12698.7 12792.7 12379.6 12503.6 12602.8 12617.4 12980.9 8069.9 8252.1 8922.2 9350.1 9403.4 11119.5 11174.4 12584.9 12845.5 12917.0 11:38:39 INFO - PROCESS | 13453 | 11:38:39 INFO - PROCESS | 13453 | [#3] mootools.html Cycles:180 Average:6046.90 Median:4929.52 stddev:3417.88 (69.3%) stddev-sans-first:3408.96 11:38:39 INFO - PROCESS | 13453 | Values: 1314.3 1444.8 1481.7 1657.8 1837.3 7986.8 8878.0 9199.9 9229.9 9491.4 9258.5 9336.7 9340.5 9344.3 9346.9 2492.6 2502.9 2506.1 2511.9 2516.8 2420.2 2491.4 2491.8 2492.5 2492.7 2470.3 2474.1 2522.4 2528.6 2528.8 2428.5 2444.7 2455.6 2462.8 2463.9 2416.0 2433.8 2441.5 2442.7 2464.0 8942.7 8989.3 9024.8 9050.7 9145.7 5440.9 5578.0 5586.2 5586.6 5602.3 3412.4 3474.5 3496.4 3519.3 3548.0 1209.0 1213.4 1224.6 1251.2 1263.2 12791.4 12804.8 12812.8 12883.3 12907.7 4742.2 4763.2 4810.3 4897.5 4961.5 9690.6 9723.9 9807.7 9810.4 9840.7 5540.1 5550.2 5550.7 5555.1 5567.9 4539.4 4665.3 5043.6 5142.7 5221.3 4071.6 4116.0 4192.9 4218.7 4234.7 1268.7 1277.3 1280.1 1285.6 1302.6 1034.6 1035.8 1043.3 1047.3 1054.1 6146.9 6295.8 6318.1 6322.1 6372.5 500.4 500.8 506.9 509.8 517.7 4343.8 4455.2 4485.0 4596.8 4607.8 11121.9 11322.9 11397.5 11399.7 11399.8 10940.6 11328.3 11331.6 11334.6 11357.1 8491.3 8709.7 8715.7 8716.6 8721.0 6441.2 6516.6 6605.2 6679.1 6758.5 10143.5 10399.2 10582.0 10656.8 10712.4 10661.8 10893.6 10894.4 10969.2 10999.2 7316.1 7773.7 7945.7 8046.6 8228.5 8813.4 8971.5 8997.7 9004.8 9017.5 7855.3 7972.0 8004.5 8068.9 8230.7 8117.4 8157.3 8170.7 8256.7 8304.9 7199.0 7214.2 7270.0 7280.2 7281.9 5129.8 5296.6 5320.7 5327.1 5341.2 5472.1 5594.4 5649.1 5712.6 5727.8 11:38:39 INFO - PROCESS | 13453 | 11:38:39 INFO - PROCESS | 13453 | [#4] prototype.html Cycles:180 Average:4807.13 Median:5510.10 stddev:1389.68 (25.2%) stddev-sans-first:1352.73 11:38:39 INFO - PROCESS | 13453 | Values: 351.0 355.9 356.4 356.6 359.7 5463.6 5497.9 5522.3 5533.0 5539.1 5382.1 5445.3 5468.0 5471.7 5478.6 4119.4 4145.6 4182.7 4268.7 4358.5 4298.5 4303.6 4314.0 4318.8 4323.7 4212.1 4262.4 4266.5 4274.2 4315.5 3992.9 4050.3 4219.3 4225.7 4260.7 3770.2 3776.5 3779.2 3783.9 3820.5 5264.3 5295.8 5297.3 5309.5 5315.9 4809.6 4859.6 4892.3 4952.0 4978.7 5585.4 5602.9 5620.9 5622.6 5631.5 4197.3 4207.3 4210.2 4215.8 4216.2 5787.3 5820.8 5842.8 5861.1 5923.2 4280.8 4285.3 4297.8 4301.3 4309.3 4371.1 4378.0 4381.5 4401.4 4404.4 4834.6 4903.7 4935.9 4951.5 4981.7 5711.6 5720.1 5720.6 5731.3 5746.9 1504.5 1512.7 1515.5 1526.3 1527.4 947.0 947.6 1002.5 1008.3 1017.9 5330.4 5389.7 5523.2 5523.8 5533.7 5833.9 5846.9 5847.7 5855.8 5858.6 5333.7 5481.3 5531.8 5545.3 5545.7 3049.1 3066.9 3084.7 3090.6 3095.8 5859.1 5999.5 6000.9 6012.3 6043.6 5854.3 5882.9 5895.8 5898.5 5899.6 5904.2 5922.3 5950.0 5964.6 5976.4 5535.4 5771.8 5778.2 5784.4 5810.5 5724.2 5743.4 5745.0 5755.2 5759.4 5806.3 5949.3 5994.2 5997.9 5999.9 4104.8 4132.1 4141.4 4167.2 4179.2 5849.0 5864.6 5883.1 5888.7 5922.5 5539.6 5652.5 5681.9 5777.9 5790.0 5658.1 5661.9 5670.7 5676.4 5689.0 5616.9 5624.3 5689.0 5707.2 5719.6 5278.9 5497.9 5629.0 5689.8 5701.2 5568.9 5572.0 5581.2 5591.9 5594.3 11:38:39 INFO - PROCESS | 13453 | 11:38:39 INFO - PROCESS | 13453 | [#5] yui.html Cycles:180 Average:21574.39 Median:4653.94 stddev:31485.82 (676.5%) stddev-sans-first:31535.42 11:38:39 INFO - PROCESS | 13453 | Values: 777.8 794.0 802.2 802.3 815.9 14471.6 15350.5 15478.7 15553.9 15803.0 13859.9 13997.9 14015.4 14024.2 14047.6 725.5 728.4 856.9 872.4 874.7 848.6 859.6 864.3 879.5 881.9 919.9 924.4 924.5 924.7 924.9 760.1 775.1 920.5 921.2 922.1 645.7 663.4 664.7 668.1 668.2 14705.8 14727.1 14733.5 14736.7 14760.8 13741.9 13792.5 14124.2 14173.9 14676.6 13235.9 13294.6 13407.9 13689.2 13811.7 4433.3 4458.7 4489.4 4653.5 4654.4 84246.2 88525.0 88558.1 88693.6 89484.0 11402.4 11500.2 11607.4 11678.4 11763.9 22021.8 22043.2 22177.3 22184.9 22879.8 8432.0 8553.6 8671.6 8830.6 8899.2 4814.8 4816.8 4821.7 4848.6 5032.3 3528.6 3660.3 3662.9 3664.7 3669.0 610.3 611.2 614.9 632.5 638.2 679.2 705.8 707.7 709.7 711.1 9216.2 9274.3 9671.5 9684.4 9731.8 676.2 682.7 693.5 703.3 710.7 4762.2 4838.2 4871.9 4932.4 4939.2 82966.2 121326.0 132820.0 136198.6 137051.0 87871.6 89827.6 113611.0 117627.0 117771.4 86115.6 88799.0 89058.6 92557.5 95167.5 10379.0 10601.9 10683.5 10761.4 10999.8 53351.0 54443.5 55004.0 56218.4 56931.4 50560.7 52113.5 53702.2 60843.7 65533.3 13628.5 14275.9 14413.4 14537.6 14682.8 15603.1 15840.9 16136.3 16167.4 16405.0 11237.7 14620.8 14775.9 14785.6 15837.8 14985.7 15199.4 15200.2 15458.1 15519.3 14931.1 15048.5 15334.8 15618.8 15871.2 12023.9 12072.8 12294.5 12514.8 12715.6 12374.3 12392.4 12429.5 12631.1 12732.2 11:38:39 INFO - PROCESS | 13453 | -------- Summary: end -------- 11:38:39 INFO - PROCESS | 13453 | 11:38:40 INFO - TEST-INFO | 13453: exit 0 11:38:40 INFO - TEST-OK | dromaeo_css | took 1114758ms 11:38:40 INFO - TEST-START | kraken 11:38:40 INFO - operating with platform_type : linux_ 11:38:40 INFO - Initialising browser for kraken test... 11:38:40 INFO - TEST-INFO | started process 13770 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcUNwwq/profile http://localhost:44230/getInfo.html) 11:38:44 INFO - PROCESS | 13770 | __metrics Screen width/height:1600/1200 11:38:44 INFO - PROCESS | 13770 | colorDepth:24 11:38:44 INFO - PROCESS | 13770 | Browser inner width/height: 1024/697 11:38:44 INFO - PROCESS | 13770 | __metrics 11:38:45 INFO - PROCESS | 13770 | 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:38:45 INFO - PROCESS | 13770 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:38:45 INFO - PROCESS | 13770 | console.error: PushService: 11:38:45 INFO - PROCESS | 13770 | stateChangeProcessEnqueue: Error transitioning state 11:38:45 INFO - PROCESS | 13770 | UnknownError 11:38:46 INFO - TEST-INFO | 13770: exit 0 11:38:46 INFO - Browser initialized. 11:38:46 INFO - Running cycle 1/1 for kraken test... 11:38:46 INFO - TEST-INFO | started process 13862 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcUNwwq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:38:57 INFO - PROCESS | 13862 | RSS: Main: 144777216 11:38:57 INFO - PROCESS | 13862 | 11:39:00 INFO - PROCESS | 13862 | Cycle 1(1): loaded http://localhost:44230/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44230/tests/kraken/driver.html?testName=audio-beat-detection) 11:39:01 INFO - PROCESS | 13862 | RSS: Main: 186761216 11:39:01 INFO - PROCESS | 13862 | 11:39:03 INFO - PROCESS | 13862 | Cycle 1(1): loaded http://localhost:44230/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44230/tests/kraken/driver.html?testName=audio-dft) 11:39:04 INFO - PROCESS | 13862 | RSS: Main: 176320512 11:39:04 INFO - PROCESS | 13862 | 11:39:07 INFO - PROCESS | 13862 | Cycle 1(1): loaded http://localhost:44230/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44230/tests/kraken/driver.html?testName=audio-fft) 11:39:07 INFO - PROCESS | 13862 | RSS: Main: 267796480 11:39:07 INFO - PROCESS | 13862 | 11:39:09 INFO - PROCESS | 13862 | Cycle 1(1): loaded http://localhost:44230/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44230/tests/kraken/driver.html?testName=audio-oscillator) 11:39:10 INFO - PROCESS | 13862 | RSS: Main: 173158400 11:39:10 INFO - PROCESS | 13862 | 11:39:12 INFO - PROCESS | 13862 | Cycle 1(1): loaded http://localhost:44230/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44230/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:39:13 INFO - PROCESS | 13862 | RSS: Main: 174993408 11:39:13 INFO - PROCESS | 13862 | 11:39:16 INFO - PROCESS | 13862 | Cycle 1(1): loaded http://localhost:44230/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44230/tests/kraken/driver.html?testName=imaging-darkroom) 11:39:16 INFO - PROCESS | 13862 | RSS: Main: 211267584 11:39:16 INFO - PROCESS | 13862 | 11:39:20 INFO - PROCESS | 13862 | Cycle 1(1): loaded http://localhost:44230/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44230/tests/kraken/driver.html?testName=imaging-desaturate) 11:39:20 INFO - PROCESS | 13862 | RSS: Main: 209805312 11:39:20 INFO - PROCESS | 13862 | 11:39:23 INFO - PROCESS | 13862 | Cycle 1(1): loaded http://localhost:44230/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44230/tests/kraken/driver.html?testName=json-parse-financial) 11:39:23 INFO - PROCESS | 13862 | RSS: Main: 209879040 11:39:23 INFO - PROCESS | 13862 | 11:39:25 INFO - PROCESS | 13862 | Cycle 1(1): loaded http://localhost:44230/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44230/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:39:26 INFO - PROCESS | 13862 | RSS: Main: 172052480 11:39:26 INFO - PROCESS | 13862 | 11:39:27 INFO - PROCESS | 13862 | Cycle 1(1): loaded http://localhost:44230/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44230/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:39:28 INFO - PROCESS | 13862 | RSS: Main: 178663424 11:39:28 INFO - PROCESS | 13862 | 11:39:30 INFO - PROCESS | 13862 | Cycle 1(1): loaded http://localhost:44230/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44230/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:39:30 INFO - PROCESS | 13862 | RSS: Main: 188788736 11:39:30 INFO - PROCESS | 13862 | 11:39:33 INFO - PROCESS | 13862 | Cycle 1(1): loaded http://localhost:44230/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44230/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:39:34 INFO - PROCESS | 13862 | RSS: Main: 196771840 11:39:34 INFO - PROCESS | 13862 | 11:39:36 INFO - PROCESS | 13862 | Cycle 1(1): loaded http://localhost:44230/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44230/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:39:37 INFO - PROCESS | 13862 | RSS: Main: 194568192 11:39:37 INFO - PROCESS | 13862 | 11:39:38 INFO - PROCESS | 13862 | Cycle 1(1): loaded http://localhost:44230/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44230/tests/kraken/driver.html?testName=ai-astar) 11:39:39 INFO - PROCESS | 13862 | RSS: Main: 243085312 11:39:39 INFO - PROCESS | 13862 | 11:39:39 INFO - PROCESS | 13862 | __start_tp_report 11:39:39 INFO - PROCESS | 13862 | _x_x_mozilla_page_load 11:39:39 INFO - PROCESS | 13862 | _x_x_mozilla_page_load_details 11:39:39 INFO - PROCESS | 13862 | |i|pagename|runs| 11:39:39 INFO - PROCESS | 13862 | |0;ai-astar;109;112;110;110;109;111;112;111;109;112 11:39:39 INFO - PROCESS | 13862 | |1;audio-beat-detection;140;116;125;156;118;119;118;119;147;123 11:39:39 INFO - PROCESS | 13862 | |2;audio-dft;160;159;160;161;161;160;161;160;161;160 11:39:39 INFO - PROCESS | 13862 | |3;audio-fft;97;75;75;114;76;77;79;76;103;76 11:39:39 INFO - PROCESS | 13862 | |4;audio-oscillator;81;81;111;81;81;80;102;80;81;102 11:39:39 INFO - PROCESS | 13862 | |5;imaging-gaussian-blur;117;116;117;117;116;117;116;117;117;117 11:39:39 INFO - PROCESS | 13862 | |6;imaging-darkroom;146;145;146;145;146;146;146;147;147;146 11:39:39 INFO - PROCESS | 13862 | |7;imaging-desaturate;95;95;95;94;94;95;95;95;95;95 11:39:39 INFO - PROCESS | 13862 | |8;json-parse-financial;50;50;49;49;49;49;50;49;49;49 11:39:39 INFO - PROCESS | 13862 | |9;json-stringify-tinderbox;59;60;61;59;60;60;60;61;61;60 11:39:39 INFO - PROCESS | 13862 | |10;stanford-crypto-aes;77;74;74;73;76;79;73;82;73;73 11:39:39 INFO - PROCESS | 13862 | |11;stanford-crypto-ccm;121;138;130;121;123;129;139;118;160;122 11:39:39 INFO - PROCESS | 13862 | |12;stanford-crypto-pbkdf2;152;155;151;152;153;153;158;152;156;154 11:39:39 INFO - PROCESS | 13862 | |13;stanford-crypto-sha256-iterative;73;64;63;63;72;62;61;62;63;62 11:39:39 INFO - PROCESS | 13862 | __end_tp_report 11:39:39 INFO - PROCESS | 13862 | __start_cc_report 11:39:39 INFO - PROCESS | 13862 | _x_x_mozilla_cycle_collect,1553 11:39:39 INFO - PROCESS | 13862 | __end_cc_report 11:39:39 INFO - PROCESS | 13862 | __startTimestamp1477593579201__endTimestamp 11:39:39 INFO - PROCESS | 13862 | 11:39:39 INFO - PROCESS | 13862 | ------- Summary: start ------- 11:39:39 INFO - PROCESS | 13862 | Number of tests: 14 11:39:39 INFO - PROCESS | 13862 | 11:39:39 INFO - PROCESS | 13862 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:1.27 (1.1%) stddev-sans-first:1.22 11:39:39 INFO - PROCESS | 13862 | Values: 109.0 112.0 110.0 110.0 109.0 111.0 112.0 111.0 109.0 112.0 11:39:39 INFO - PROCESS | 13862 | 11:39:39 INFO - PROCESS | 13862 | [#1] audio-beat-detection Cycles:10 Average:128.10 Median:124.00 stddev:14.26 (11.5%) stddev-sans-first:14.45 11:39:39 INFO - PROCESS | 13862 | Values: 140.0 116.0 125.0 156.0 118.0 119.0 118.0 119.0 147.0 123.0 11:39:39 INFO - PROCESS | 13862 | 11:39:39 INFO - PROCESS | 13862 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.67 (0.4%) stddev-sans-first:0.71 11:39:39 INFO - PROCESS | 13862 | Values: 160.0 159.0 160.0 161.0 161.0 160.0 161.0 160.0 161.0 160.0 11:39:39 INFO - PROCESS | 13862 | 11:39:39 INFO - PROCESS | 13862 | [#3] audio-fft Cycles:10 Average:84.80 Median:76.00 stddev:14.34 (18.9%) stddev-sans-first:14.52 11:39:39 INFO - PROCESS | 13862 | Values: 97.0 75.0 75.0 114.0 76.0 77.0 79.0 76.0 103.0 76.0 11:39:39 INFO - PROCESS | 13862 | 11:39:39 INFO - PROCESS | 13862 | [#4] audio-oscillator Cycles:10 Average:88.00 Median:81.00 stddev:11.99 (14.8%) stddev-sans-first:12.45 11:39:39 INFO - PROCESS | 13862 | Values: 81.0 81.0 111.0 81.0 81.0 80.0 102.0 80.0 81.0 102.0 11:39:39 INFO - PROCESS | 13862 | 11:39:39 INFO - PROCESS | 13862 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 11:39:39 INFO - PROCESS | 13862 | Values: 117.0 116.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 11:39:39 INFO - PROCESS | 13862 | 11:39:39 INFO - PROCESS | 13862 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 11:39:39 INFO - PROCESS | 13862 | Values: 146.0 145.0 146.0 145.0 146.0 146.0 146.0 147.0 147.0 146.0 11:39:39 INFO - PROCESS | 13862 | 11:39:39 INFO - PROCESS | 13862 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:39:39 INFO - PROCESS | 13862 | Values: 95.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 11:39:39 INFO - PROCESS | 13862 | 11:39:39 INFO - PROCESS | 13862 | [#8] json-parse-financial Cycles:10 Average:49.30 Median:49.00 stddev:0.48 (1.0%) stddev-sans-first:0.44 11:39:39 INFO - PROCESS | 13862 | Values: 50.0 50.0 49.0 49.0 49.0 49.0 50.0 49.0 49.0 49.0 11:39:39 INFO - PROCESS | 13862 | 11:39:39 INFO - PROCESS | 13862 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 11:39:39 INFO - PROCESS | 13862 | Values: 59.0 60.0 61.0 59.0 60.0 60.0 60.0 61.0 61.0 60.0 11:39:39 INFO - PROCESS | 13862 | 11:39:39 INFO - PROCESS | 13862 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:75.00 stddev:3.10 (4.1%) stddev-sans-first:3.23 11:39:39 INFO - PROCESS | 13862 | Values: 77.0 74.0 74.0 73.0 76.0 79.0 73.0 82.0 73.0 73.0 11:39:39 INFO - PROCESS | 13862 | 11:39:39 INFO - PROCESS | 13862 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:129.50 stddev:12.76 (9.9%) stddev-sans-first:13.10 11:39:39 INFO - PROCESS | 13862 | Values: 121.0 138.0 130.0 121.0 123.0 129.0 139.0 118.0 160.0 122.0 11:39:39 INFO - PROCESS | 13862 | 11:39:39 INFO - PROCESS | 13862 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.60 Median:153.50 stddev:2.17 (1.4%) stddev-sans-first:2.22 11:39:39 INFO - PROCESS | 13862 | Values: 152.0 155.0 151.0 152.0 153.0 153.0 158.0 152.0 156.0 154.0 11:39:39 INFO - PROCESS | 13862 | 11:39:39 INFO - PROCESS | 13862 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:63.00 stddev:4.30 (6.8%) stddev-sans-first:3.28 11:39:39 INFO - PROCESS | 13862 | Values: 73.0 64.0 63.0 63.0 72.0 62.0 61.0 62.0 63.0 62.0 11:39:39 INFO - PROCESS | 13862 | -------- Summary: end -------- 11:39:39 INFO - PROCESS | 13862 | 11:39:40 INFO - TEST-INFO | 13862: exit 0 11:39:40 INFO - TEST-OK | kraken | took 59876ms 11:39:40 INFO - SUITE-END | took 1174s 11:39:40 INFO - Completed test suite (00:19:34) 11:39:40 INFO - javascript benchmark 11:39:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3115.361350923061, 3154.3218208085264, 3164.7626428017907, 3178.4278829810623, 3210.1011716719313, 5464.781408743651, 5551.805686800963, 5555.055640541108, 5568.025595520783, 5572.832815015546, 5634.746436410361, 5705.714714264281, 5710.971445142768, 5712.11462223356, 5727.713614319277, 5100.387953445583, 5120.078385890538, 5138.845834624967, 5200.791968321281, 5205.739713014353, 4952.801887924478, 5181.974090129563, 5204.193350030751, 5209.244659524366, 5211.557017653504, 4913.606911447076, 5047.596192304607, 5054.1660625996665, 5084.389873215219, 5093.236014597803, 5088.4911508849, 5116.360454943114, 5121.769520371592, 5187.429382767892, 5199.168133098686, 5006.374203224597, 5087.414947281073, 5153.458886816868, 5174.042802081627, 5197.986392653434, 5340.412554618989, 5389.730513474311, 5468.316460442445, 5509.283793106871, 5560.916586251209, 5932.080527518198, 5937.139114828326, 5972.761089556412, 6044.2746870375395, 6046.848828779316, 6028.547858910555, 6071.4535691787505, 6075.05836595324, 6082.878342433127, 6084.908726369108, 5418.458154184589, 5440.238366628715, 5489.39616642169, 5504.394516603171, 5512.6968016759465, 6168.352323006109, 6208.4722798561725, 6211.0, 6211.689415529206, 6215.471684906744, 5911.674857882772, 5945.137954996588, 5945.346011938684, 5957.880842383215, 5957.880842383215, 5782.537397008229, 5832.766689332379, 5839.5036421904615, 5886.852828679317, 5910.881782364415, 5950.166976623276, 5950.642961422329, 5953.315368732565, 5955.910661340084, 5978.372270911578, 5914.674692891932, 5954.46409823118, 5983.102534619842, 5983.6708981005595, 6005.849853753691, 4443.37792709021, 4466.977665111719, 4545.568171023748, 4593.356930029799, 4596.057808149321, 4072.3891416287793, 4112.115895082572, 4125.876223713293, 4126.195391898551, 4143.7306575072525, 5683.857903552444, 5696.3733989261145, 5703.572232082611, 5705.258316418922, 5705.657660540381, 5787.247657804459, 5843.357230704619, 5885.61743486672, 6063.181470501426, 6072.423119803611, 5582.8325150245555, 5657.179708942181, 5657.8019769307875, 5678.602497825113, 5694.629849059881, 5018.2974383586325, 5041.117804384291, 5053.974730126326, 5055.87360315995, 5090.821821236313, 5943.821685349447, 6076.756929722762, 6144.2319710036245, 6153.1693221415435, 6158.630482171084, 5959.582829201914, 6013.849653758691, 6039.4262545058145, 6100.877982440237, 6133.4786543142545, 6215.098810672517, 6251.749930002931, 6256.843578910563, 6265.091561723433, 6269.96865015672, 5621.690807005654, 5974.641521508724, 5977.163197152489, 5981.475948610661, 6021.608595441282, 5680.0, 5867.559933004956, 5905.970470147622, 5910.231669882888, 6029.366916473882, 5781.132830075522, 5830.4461076197695, 5832.125181222681, 5836.241288632451, 5838.766449341979, 5829.358770535153, 5830.708464576839, 5833.125031245348, 5837.591368604157, 5844.883102338014, 5554.921583122857, 5707.5433965281845, 5806.303243610625, 5835.0, 5865.149553314831, 5975.7012149391485, 5977.22296101504, 5983.730732117152, 5983.820485385445, 5985.102234664835, 5569.554435645057, 5831.300243970581, 5832.650040997553, 5837.241158649348, 5840.853978650568], "value": 5509.290836653971, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.1500801326057, 611.260374946315, 638.7636574467444, 648.6562122075298, 649.6459429610861, 37370.0, 45966.31050534241, 46648.76675616625, 46726.29910551345, 51577.2263416049, 41933.7903310483, 42402.7879860601, 42474.7876260619, 42556.36165457521, 42629.57370426295, 8327.875081873777, 9177.724668259947, 9296.209822165125, 9335.719928402124, 9339.533023348838, 8166.918330816705, 11148.21962462628, 11432.2569033013, 11435.256708313933, 11438.256513326607, 11297.435128243596, 11354.148438867118, 11357.091432685365, 11365.261258018243, 11375.431228438545, 10837.458127093614, 10871.45642717865, 10938.835917461245, 10942.398168100752, 10952.507137178845, 10954.507047182897, 10959.726006849813, 11016.889831101667, 11033.227674062819, 11037.558497660084, 44837.10325793466, 44844.32733509, 44911.550884491066, 45230.54769452296, 45265.0, 3784.2620688965662, 3901.8634347797692, 3913.2760439318818, 3966.5037549171525, 3981.243563722883, 33828.49257261143, 35085.82457087724, 36135.27729445396, 36140.09649758751, 36292.27415451703, 4050.4936882889638, 4070.796460177009, 4093.4269202311702, 4102.384642303648, 4119.670426365884, 398099.0, 404844.0, 405794.9130763041, 407431.0, 407704.0, 71955.28044719486, 72930.0, 73050.63474682592, 73066.26933730594, 73188.26811731921, 42356.57643423588, 43195.92010199707, 43376.0, 45329.54670453319, 45537.316940245924, 18662.253509859725, 18761.06194690287, 18794.0, 18804.811951880307, 18811.059447027594, 13325.73348533024, 13487.460501580023, 13516.864831351757, 13602.659933501543, 14108.153510789385, 21966.0, 22946.7705322948, 23038.42403939915, 23064.192753253556, 23066.19268325634, 7961.0, 8103.6758529658155, 8181.754547363588, 8212.671493140208, 8438.662453501915, 1029.4235228272191, 1040.9791804164026, 1104.608193675974, 1119.9328040317444, 1127.1208457403238, 34708.82645586807, 35054.91703702949, 35148.648513514534, 35310.823445882605, 35321.64678353183, 1087.8477013218155, 1132.9433528323716, 1160.1762748448696, 1161.3322339654565, 1208.504513149622, 17976.820231797778, 18433.0, 18440.17019234111, 18441.631167376578, 18448.723269150974, 598906.0, 607566.0, 611745.0, 614088.0, 614260.0, 64013.35986640167, 64408.35591644117, 64604.0, 64678.0, 64773.352266477676, 1332.6934804994905, 1365.6722386627139, 1383.384393944685, 1412.25150670145, 1452.259347732643, 31563.368732625677, 35351.8102372035, 35717.82141089278, 35865.58226829889, 35918.640813591526, 53300.46699532955, 53708.19437708359, 54116.18825717696, 54138.45861541334, 54158.72920635372, 409300.0, 410020.0, 410142.0, 410692.0, 410803.0, 32434.0, 33084.834575826964, 33357.0, 33838.154046149044, 34465.65534344625, 51838.22242666288, 52258.0, 52369.3341466109, 53051.20423193578, 53314.0, 38510.2297954045, 38619.0, 38696.41955370728, 39413.605863941, 39904.60095399009, 37776.05559860916, 37807.0, 38118.23763524769, 39802.60197397989, 39823.60176398199, 43046.56953430425, 43426.782866085465, 44088.0, 44642.3303650452, 46679.29981050219, 37975.810120949216, 39727.40408893926, 40938.795306023276, 41112.58887411088, 41404.58595414007, 28827.388417281745, 29830.403391931606, 29969.74956607984, 29981.400371992873, 29998.0], "value": 21660.28621634246, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.76929380959047, 416.5418040155829, 417.5135966598912, 420.5941266677655, 440.2625602116454, 14791.704165916675, 16398.836011639894, 19894.00529973501, 20578.588428231425, 21596.0, 19501.707474387895, 19686.0, 19947.800521994814, 20104.09531571079, 20116.29592964243, 5987.191729116579, 6055.788047418341, 6098.32918378978, 6124.571280010401, 6162.661053642048, 6020.518358531329, 6108.480779133779, 6113.174721412619, 6115.541334399915, 6121.418465245817, 5715.228444160048, 5943.108533719934, 5985.6408615483215, 6093.177421048146, 6105.358937311585, 5791.276090488689, 5907.5864689471755, 6001.129836173752, 6038.33578306386, 6040.184575082373, 5781.161731548944, 5785.595008349417, 5790.36306006339, 5790.652560846321, 5791.305043394777, 14484.92757536216, 14511.419543218259, 14567.344469498898, 14632.0, 14663.41346346145, 2405.7594240575804, 2421.3583400398907, 2514.459391230894, 2531.4304281536693, 2585.5475291824046, 10575.894241057567, 10702.946485267601, 10772.461376931122, 10778.676639700743, 13830.446782128703, 1929.1415320182525, 2022.4337185588058, 2064.2465500092508, 2073.2536286936693, 2081.8646787958733, 83038.58480707619, 87968.0, 88651.55674221652, 89900.55049724775, 93432.0, 11112.888871111347, 11298.830517542243, 11392.715182120513, 11454.59908903201, 11474.713132171762, 16892.746608800877, 16898.07060611678, 16933.238004289837, 16934.153292335333, 16934.576635583962, 8595.226429621363, 8790.692325768567, 8843.867341989875, 8927.776805579913, 9003.594838232295, 8550.1449855014, 8602.053774084845, 8605.182507661762, 8768.167024132697, 8818.250448711931, 4984.177610694267, 5008.4240312364545, 5046.62150338726, 5059.620528460307, 5132.871678208, 2061.5361543652557, 2074.1392322186125, 2106.6734656128324, 2128.7445506539007, 2136.4979229880964, 929.972100836976, 963.8843338799248, 971.8056388722284, 1056.5562463765236, 1121.5738019552518, 20270.594588108157, 20926.895365523378, 21024.89487552583, 21107.788922110583, 21147.25984590532, 1002.9749256268506, 1009.7475631092227, 1033.8190816607064, 1061.135174832509, 1074.4412905289362, 10772.274457689296, 11054.22620416563, 11162.274452160584, 11513.654590362303, 11595.420228988516, 412032.0, 414966.0, 417247.0, 528050.0, 534924.0, 59986.70006649939, 60951.80109592873, 100743.955362677, 102189.0, 105001.47499262454, 981.504340308154, 985.0, 1019.9439030853374, 1020.4336593190702, 1025.8307379282335, 18388.540286492946, 18862.339818106302, 18989.240430383183, 19207.135678894763, 19469.902650486656, 31237.375252494367, 31823.840880795447, 31919.0, 42481.78759106308, 45565.77217113893, 62727.0, 63348.68325658527, 63523.682381587794, 63568.364316356245, 63975.3602463988, 9362.535861731203, 9520.809898762654, 9522.190613797904, 9527.809443810946, 9640.42157470554, 13574.0, 13838.37727302294, 14167.43330266819, 14332.472179053446, 14665.92667036658, 12187.695307617381, 12462.0, 12494.500219991098, 12796.488140474277, 13080.215187088805, 11575.189736718687, 11820.290782553075, 12685.0, 12698.746025079632, 12792.74414511686, 12379.62861114168, 12503.56237531682, 12602.810957835456, 12617.369131543202, 12980.935095324463, 8069.919300807152, 8252.133525979685, 8922.197002269826, 9350.111739384747, 9403.43579385239, 11119.499622517167, 11174.35694974033, 12584.937075314565, 12845.486180552673, 12917.0], "value": 9513.786000746772, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.3099872566895, 1444.768836986082, 1481.6592183797727, 1657.825928277531, 1837.2926423327024, 7986.800329991753, 8877.955610221949, 9199.862002069975, 9229.861552076716, 9491.430514169155, 9258.490783006931, 9336.719898403042, 9340.486273254985, 9344.252459803216, 9346.859797103049, 2492.6136448850457, 2502.887370068351, 2506.0602274147195, 2511.8744062796877, 2516.811239157061, 2420.249722585995, 2491.402063504764, 2491.7632824881607, 2492.538880307149, 2492.675952126221, 2470.3206618179966, 2474.1464194852747, 2522.445062086338, 2528.633348164515, 2528.835625684334, 2428.5142971405703, 2444.6699695541142, 2455.594826853567, 2462.7660372264604, 2463.8768061596847, 2415.9879200603887, 2433.829631925766, 2441.5483135619966, 2442.68245128134, 2464.039024780337, 8942.68700595476, 8989.325800564984, 9024.819503609957, 9050.683226087056, 9145.725628231165, 5440.891182176374, 5578.0, 5586.217929489874, 5586.608937374385, 5602.327720673505, 3412.351653185887, 3474.4614584739406, 3496.4056110461283, 3519.260955199411, 3547.9822600886832, 1208.9818652720217, 1213.4236237787068, 1224.571002238249, 1251.2054845173288, 1263.1663102352404, 12791.424385902657, 12804.80792788109, 12812.80780788289, 12883.291418971952, 12907.677308067374, 4742.188940206975, 4763.2140696784645, 4810.278458231293, 4897.534734200245, 4961.50384961501, 9690.612375504901, 9723.854142187873, 9807.656732014346, 9810.362326448758, 9840.655577054911, 5540.085885828793, 5550.16747487872, 5550.694711790809, 5555.111182210827, 5567.944320556742, 4539.387182730356, 4665.323528088408, 5043.571296439771, 5142.717150556755, 5221.269022336875, 4071.5521292657786, 4115.9588404115575, 4192.874213773592, 4218.6625069994325, 4234.6823988201, 1268.6828292926768, 1277.303869391184, 1280.0975312404732, 1285.6207418811287, 1302.602706174607, 1034.6275340877278, 1035.8394448860438, 1043.2801367056707, 1047.2983101322131, 1054.082947835388, 6146.938530614726, 6295.7737350371335, 6318.115463835067, 6322.083297921776, 6372.522060845455, 500.37952938356904, 500.79558661419344, 506.8656805946427, 509.78588992623185, 517.6842126302952, 4343.782810859444, 4455.1535208310315, 4484.977575112103, 4596.839110631178, 4607.792649330788, 11121.888781112248, 11322.94338528302, 11397.544098236143, 11399.715007124889, 11399.772004559862, 10940.56237750497, 11328.32030078198, 11331.60339388134, 11334.60328888485, 11357.148213883827, 8491.320694344438, 8709.651613935499, 8715.651373945098, 8716.564171791386, 8721.0, 6441.194850643669, 6516.57642253252, 6605.174353205849, 6679.131712877489, 6758.459323254227, 10143.492825358555, 10399.220058495794, 10582.0, 10656.840147397641, 10712.410817405118, 10661.840072398765, 10893.618723344645, 10894.400807955639, 10969.23215374916, 10999.175061870232, 7316.122065351979, 7773.650185741768, 7945.721899733481, 8046.557439340892, 8228.547429891414, 8813.427127236966, 8971.461712297283, 8997.730068097968, 9004.819903602021, 9017.504037278013, 7855.33229675484, 7972.0, 8004.51972881629, 8068.919310807051, 8230.670773169006, 8117.350611951148, 8157.306628936607, 8170.714025009096, 8256.711015114442, 8304.916950830415, 7198.964005179941, 7214.170370407471, 7269.963650181715, 7280.1991780903, 7281.854362912606, 5129.7691603877165, 5296.576273898156, 5320.733963301742, 5327.067763141512, 5341.225522299167, 5472.124460086367, 5594.4125866785025, 5649.067903795828, 5712.600117991867, 5727.828165155052], "value": 4780.091958681928, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.97894126352423, 355.92525569630374, 356.3959089343562, 356.6023883370043, 359.7212160575552, 5463.617546771728, 5497.917531237024, 5522.254495643087, 5533.0, 5539.086050801613, 5382.111951528003, 5445.264889239951, 5468.0, 5471.699056551888, 5478.616496845212, 4119.382092686106, 4145.5647157048525, 4182.665386769051, 4268.701190916637, 4358.455193100863, 4298.527162012176, 4303.591158839905, 4314.0, 4318.784060796947, 4323.718958267703, 4212.136512015045, 4262.360645903123, 4266.530681625019, 4274.230638485072, 4315.4605674290715, 3992.920141597166, 4050.250703619825, 4219.261629214875, 4225.732280315893, 4260.723053001545, 3770.245950809849, 3776.4524143998965, 3779.225258821935, 3783.9432408513894, 3820.541535015816, 5264.341507538668, 5295.841124766224, 5297.284866543006, 5309.495597918191, 5315.920261196085, 4809.591184749265, 4859.635527335428, 4892.266160075981, 4951.950480495185, 4978.701277923336, 5585.385607583163, 5602.915956260659, 5620.859478513029, 5622.634528755618, 5631.521320687746, 4197.265478541273, 4207.305794543927, 4210.179015092058, 4215.810288537024, 4216.156768646283, 5787.276590426197, 5820.767169313265, 5842.766289348421, 5861.062230043172, 5923.229980102602, 4280.79539037396, 4285.335772955197, 4297.82808687649, 4301.257990513847, 4309.310510318334, 4371.147626212922, 4377.971176773456, 4381.496127945264, 4401.405810215644, 4404.427424434803, 4834.613230941516, 4903.681260718042, 4935.87660308488, 4951.5048495150195, 4981.701097934136, 5711.628744131618, 5720.11338242573, 5720.599558030981, 5731.254936858182, 5746.856328591819, 1504.50351384043, 1512.7125846089207, 1515.4847351900407, 1526.2521364531522, 1527.4424834935392, 946.9810603787886, 947.6067432015774, 1002.4636819301638, 1008.2690049713899, 1017.9185665146771, 5330.38700549434, 5389.730513474311, 5523.226748255248, 5523.8066667666435, 5533.695646739468, 5833.854153646108, 5846.853828654318, 5847.707614619252, 5855.833341663527, 5858.56060795442, 5333.663121444472, 5481.2874326338115, 5531.751071201725, 5545.306836645419, 5545.72271386429, 3049.054793014173, 3066.861991210401, 3084.6606873243927, 3090.5827713258873, 3095.8297293649066, 5859.129026776849, 5999.520038396918, 6000.939990600125, 6012.338642749294, 6043.607165534227, 5854.2974843018255, 5882.941170588325, 5895.823125306248, 5898.490398213056, 5899.616524925952, 5904.225014243299, 5922.3485416605, 5949.970250148722, 5964.642121472725, 5976.402359763989, 5535.39110697831, 5771.797987070432, 5778.219940308173, 5784.392638773036, 5810.54736315921, 5724.198612194379, 5743.420559346213, 5745.0, 5755.223044888887, 5759.424057594207, 5806.303243610793, 5949.3455719871645, 5994.15277743086, 5997.860406522746, 5999.880002400015, 4104.794760262034, 4132.111596006873, 4141.378793181047, 4167.229062623424, 4179.164167166518, 5848.970755146197, 5864.589478736448, 5883.146808755228, 5888.67504811414, 5922.496587789914, 5539.642787517084, 5652.463016013637, 5681.9431805681415, 5777.9133313001175, 5789.9710501447225, 5658.094704847204, 5661.886762264814, 5670.69573997991, 5676.4323567642905, 5688.971555142198, 5616.915746263891, 5624.29696287964, 5688.971555142198, 5707.1737044145475, 5719.599628025998, 5278.9472105278455, 5497.945020549743, 5628.971855140698, 5689.829305120853, 5701.173329867229, 5568.888622227614, 5572.0, 5581.176893827741, 5591.888162236651, 5594.328680558359], "value": 4369.590547871108, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.8444311137774, 794.0312818361599, 802.1897883138029, 802.2779498451389, 815.8572249856276, 14471.638209044779, 15350.539483815475, 15478.69042619147, 15553.922230388845, 15803.0, 13859.93070034651, 13997.930010349934, 14015.369308381121, 14024.228667423287, 14047.648808779786, 725.4522835259372, 728.4281838756577, 856.8971723393202, 872.3806097670662, 874.6851133591902, 848.5714714069417, 859.5873980489368, 864.2653744317342, 879.4503435352905, 881.8809460722816, 919.9172074513292, 924.3760461688368, 924.4684306523742, 924.7456949338952, 924.856647219682, 760.0992823504165, 775.0737868247446, 920.5075284722675, 921.1525396635078, 922.0871337376017, 645.699749616426, 663.4460225711537, 664.6577012838392, 668.0513670587777, 668.2248591633681, 14705.779413308808, 14727.116373017654, 14733.484328048467, 14736.705265894621, 14760.778588321184, 13741.931290343584, 13792.517261895886, 14124.152550846982, 14173.929130354281, 14676.633084172874, 13235.914985769718, 13294.601161965156, 13407.932960335233, 13689.178649280975, 13811.654708632264, 4433.2685106957315, 4458.71018383804, 4489.438820147481, 4653.464851542082, 4654.418197725285, 84246.15753842445, 88525.0, 88558.11441885564, 88693.55653221822, 89484.0, 11402.429878506042, 11500.194986351042, 11607.419629018515, 11678.416079196006, 11763.941180294214, 22021.77978220197, 22043.228487002878, 22177.334679959626, 22184.889075554518, 22879.771202287764, 8431.957840210882, 8553.588657871505, 8671.56642167889, 8830.646774128963, 8899.243564297107, 4814.807407703723, 4816.759162041884, 4821.662483626113, 4848.5636292733825, 5032.32063671407, 3528.6471352865024, 3660.3228402745576, 3662.8717994870585, 3664.688501477351, 3669.027707657473, 610.3408319015541, 611.2267981004034, 614.9446549810539, 632.4687262699263, 638.2341190571241, 679.1985457160598, 705.7917914215319, 707.6673963237271, 709.7090193020837, 711.1146622454974, 9216.216621587106, 9274.258059355236, 9671.468069256118, 9684.41893486379, 9731.805363892683, 676.1615596660205, 682.7303215229956, 693.4868197533789, 703.3388614702163, 710.7476845719798, 4762.190427627312, 4838.225883858566, 4871.878203044952, 4932.4327702314695, 4939.234418665113, 82966.17033829704, 121326.0, 132820.0, 136198.59503512294, 137051.0, 87871.56064219766, 89827.55086224657, 113611.0, 117627.0, 117771.41114294545, 86115.56942215249, 88799.0, 89058.55470722605, 92557.5372123135, 95167.52416237874, 10379.0, 10601.893981060399, 10683.5192416343, 10761.354318740901, 10999.780004399707, 53351.0, 54443.45556544384, 55004.0, 56218.43781562296, 56931.43068569261, 50560.70843161609, 52113.47886521238, 53702.194467083806, 60843.69578152081, 65533.34466655272, 13628.523001694894, 14275.928620356832, 14413.351399186851, 14537.636559086108, 14682.77975830342, 15603.141827199614, 15840.920795395949, 16136.273867676218, 16167.434139805051, 16405.0, 11237.662870113909, 14620.780688289897, 14775.9337964651, 14785.630359241106, 15837.841621583637, 14985.700285994437, 15199.392024318904, 15200.163990980602, 15458.14980176056, 15519.301631426388, 14931.10413375201, 15048.548543543711, 15334.846651533342, 15618.84381156174, 15871.206439677739, 12023.879761202275, 12072.75854482888, 12294.474745315256, 12514.812277816021, 12715.55495557651, 12374.257544546996, 12392.442340094898, 12429.50845898498, 12631.115821892747, 12732.172408793398], "value": 7872.505534924323, "unit": "score"}], "name": "dromaeo_css", "value": 7560.05140391227, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 110.0, 110.0, 109.0, 111.0, 112.0, 111.0, 109.0, 112.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 116.0, 125.0, 156.0, 118.0, 119.0, 118.0, 119.0, 147.0, 123.0], "value": 128.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 160.0, 161.0, 161.0, 160.0, 161.0, 160.0, 161.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 75.0, 75.0, 114.0, 76.0, 77.0, 79.0, 76.0, 103.0, 76.0], "value": 84.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 111.0, 81.0, 81.0, 80.0, 102.0, 80.0, 81.0, 102.0], "value": 88.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 49.0, 49.0, 49.0, 49.0, 50.0, 49.0, 49.0, 49.0], "value": 49.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 61.0, 59.0, 60.0, 60.0, 60.0, 61.0, 61.0, 60.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 74.0, 73.0, 76.0, 79.0, 73.0, 82.0, 73.0, 73.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 138.0, 130.0, 121.0, 123.0, 129.0, 139.0, 118.0, 160.0, 122.0], "value": 130.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 155.0, 151.0, 152.0, 153.0, 153.0, 158.0, 152.0, 156.0, 154.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 64.0, 63.0, 63.0, 72.0, 62.0, 61.0, 62.0, 63.0, 62.0], "value": 64.5, "unit": "score"}], "name": "kraken", "value": 1462.1999999999998, "alertThreshold": 2.0}]} 11:39:40 INFO - Return code: 0 11:39:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:39:40 INFO - # TBPL SUCCESS # 11:39:40 INFO - Running post-action listener: _resource_record_post_action 11:39:40 INFO - [mozharness: 2016-10-27 18:39:40.504443Z] Finished run-tests step (success) 11:39:40 INFO - Running post-run listener: _resource_record_post_run 11:39:40 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 262144; Write bytes: 357904384; Read time: 12; Write time: 220884 11:39:40 INFO - TinderboxPrint: CPU usage
12.9% 11:39:40 INFO - TinderboxPrint: I/O read bytes / time
262,144 / 12 11:39:40 INFO - TinderboxPrint: I/O write bytes / time
357,904,384 / 220,884 11:39:40 INFO - TinderboxPrint: CPU idle
8,275.9 (87.1%) 11:39:40 INFO - TinderboxPrint: CPU user
1,186.0 (12.5%) 11:39:40 INFO - TinderboxPrint: Swap in / out
0 / 0 11:39:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107327488; Read time: 0; Write time: 70720 11:39:40 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 262144; Write bytes: 250576896; Read time: 12; Write time: 150164 11:39:41 INFO - Running post-run listener: _upload_blobber_files 11:39:41 INFO - Blob upload gear active. 11:39:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:39:41 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:39:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:39:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:39:41 INFO - (blobuploader) - INFO - Open directory for files ... 11:39:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:39:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:39:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:44 INFO - (blobuploader) - INFO - Done attempting. 11:39:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:39:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:39:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:45 INFO - (blobuploader) - INFO - Done attempting. 11:39:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:39:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:39:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:46 INFO - (blobuploader) - INFO - Done attempting. 11:39:46 INFO - (blobuploader) - INFO - Iteration through files over. 11:39:46 INFO - Return code: 0 11:39:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:39:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:39:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/932eac3cafe761014470083fe4f30d4756788e292c52b95d5c9bedc10172258b0db17cbcf00b87ac097753324f387bb85ab4c7dd2c53203d65bf515c103f5b2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d3e93f54c14556335a8f5ae8b8162955eda4dd29328fc21ec298c506d73d993bc55534475d2361accec5b41c91e7b453482a86961c84e9f7f657c6485565e37", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f3c7d33d52f273a3c2754d6f5e335ade15d239c5c3319295de53b13880195b99a5b67b88c3d26d579a774f3b31c7c859e799814a0c0c46bb30458fe9b6a49aa"} 11:39:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:39:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:39:46 INFO - Contents: 11:39:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/932eac3cafe761014470083fe4f30d4756788e292c52b95d5c9bedc10172258b0db17cbcf00b87ac097753324f387bb85ab4c7dd2c53203d65bf515c103f5b2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d3e93f54c14556335a8f5ae8b8162955eda4dd29328fc21ec298c506d73d993bc55534475d2361accec5b41c91e7b453482a86961c84e9f7f657c6485565e37", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f3c7d33d52f273a3c2754d6f5e335ade15d239c5c3319295de53b13880195b99a5b67b88c3d26d579a774f3b31c7c859e799814a0c0c46bb30458fe9b6a49aa"} 11:39:46 INFO - Running post-run listener: copy_logs_to_upload_dir 11:39:46 INFO - Copying logs to upload dir... 11:39:46 INFO - mkdir: /builds/slave/test/build/upload/logs 11:39:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.093738 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-10-27 11:39:46.145121) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 11:39:46.148875) ========= 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=db0483c52d987ecb441a263b000001ad-1477592350.353143-124687251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/932eac3cafe761014470083fe4f30d4756788e292c52b95d5c9bedc10172258b0db17cbcf00b87ac097753324f387bb85ab4c7dd2c53203d65bf515c103f5b2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d3e93f54c14556335a8f5ae8b8162955eda4dd29328fc21ec298c506d73d993bc55534475d2361accec5b41c91e7b453482a86961c84e9f7f657c6485565e37", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f3c7d33d52f273a3c2754d6f5e335ade15d239c5c3319295de53b13880195b99a5b67b88c3d26d579a774f3b31c7c859e799814a0c0c46bb30458fe9b6a49aa"} build_url:https://queue.taskcluster.net/v1/task/S6Nj6k24QsyOG113-d7gww/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011347 build_url: 'https://queue.taskcluster.net/v1/task/S6Nj6k24QsyOG113-d7gww/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/932eac3cafe761014470083fe4f30d4756788e292c52b95d5c9bedc10172258b0db17cbcf00b87ac097753324f387bb85ab4c7dd2c53203d65bf515c103f5b2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d3e93f54c14556335a8f5ae8b8162955eda4dd29328fc21ec298c506d73d993bc55534475d2361accec5b41c91e7b453482a86961c84e9f7f657c6485565e37", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f3c7d33d52f273a3c2754d6f5e335ade15d239c5c3319295de53b13880195b99a5b67b88c3d26d579a774f3b31c7c859e799814a0c0c46bb30458fe9b6a49aa"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 11:39:46.175038) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 11:39:46.175412) ========= 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=db0483c52d987ecb441a263b000001ad-1477592350.353143-124687251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 11:39:46.257595) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 11:39:46.257953) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 11:39:46.258279) ========= ========= Total master_lag: 0.17 =========