builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1481235231.99 results: success (0) buildid: 20161208141305 builduid: ab8ee06629fb4b20884a49b51ffb7003 revision: 195138298619f5ee4c99dd17df0df98737762a25 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-08 14:13:51.989265) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-08 14:13:51.989712) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-08 14:13:51.989990) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-08 14:13:52.004344) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 14:13:52.004613) ========= 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=3836458cccd887f2d2de3cf1000001de-1481235231.536358-1396771756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-08 14:13:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 37.9M=0s 2016-12-08 14:13:52 (37.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.079219 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 14:13:52.098278) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 14:13:52.098597) ========= 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=3836458cccd887f2d2de3cf1000001de-1481235231.536358-1396771756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015864 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 14:13:52.148098) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 14:13:52.148450) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 195138298619f5ee4c99dd17df0df98737762a25 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 195138298619f5ee4c99dd17df0df98737762a25 --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=3836458cccd887f2d2de3cf1000001de-1481235231.536358-1396771756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-08 14:13:52,369 truncating revision to first 12 chars 2016-12-08 14:13:52,369 Setting DEBUG logging. 2016-12-08 14:13:52,369 attempt 1/10 2016-12-08 14:13:52,369 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/195138298619?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-08 14:13:52,694 unpacking tar archive at: mozilla-inbound-195138298619/testing/mozharness/ program finished with exit code 0 elapsedTime=0.636290 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 14:13:52.798063) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-08 14:13:52.798388) ========= script_repo_revision: 195138298619f5ee4c99dd17df0df98737762a25 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-08 14:13:52.798787) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-08 14:13:52.799071) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-08 14:13:52.806975) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-12-08 14:13:52.807301) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=3836458cccd887f2d2de3cf1000001de-1481235231.536358-1396771756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:13:53 INFO - MultiFileLogger online at 20161208 14:13:53 in /builds/slave/test 14:13:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 14:13:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:13:53 INFO - {'append_to_log': False, 14:13:53 INFO - 'base_work_dir': '/builds/slave/test', 14:13:53 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 14:13:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:13:53 INFO - 'branch': 'Mozilla-Inbound', 14:13:53 INFO - 'buildbot_json_path': 'buildprops.json', 14:13:53 INFO - 'config_files': ('talos/linux_config.py',), 14:13:53 INFO - 'default_actions': ('clobber', 14:13:53 INFO - 'read-buildbot-config', 14:13:53 INFO - 'download-and-extract', 14:13:53 INFO - 'populate-webroot', 14:13:53 INFO - 'create-virtualenv', 14:13:53 INFO - 'install', 14:13:53 INFO - 'run-tests'), 14:13:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:13:53 INFO - 'download_minidump_stackwalk': True, 14:13:53 INFO - 'download_symbols': 'ondemand', 14:13:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:13:53 INFO - 'tooltool.py': '/tools/tooltool.py', 14:13:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:13:53 INFO - '/tools/misc-python/virtualenv.py')}, 14:13:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:13:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:13:53 INFO - 'installer_path': 'installer.exe', 14:13:53 INFO - 'log_level': 'info', 14:13:53 INFO - 'log_name': 'talos', 14:13:53 INFO - 'log_to_console': True, 14:13:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:13:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:13:53 INFO - 'opt_config_files': (), 14:13:53 INFO - 'pip_index': False, 14:13:53 INFO - 'sps_profile': False, 14:13:53 INFO - 'sps_profile_interval': 0, 14:13:53 INFO - 'suite': 'dromaeojs', 14:13:53 INFO - 'system_bits': '32', 14:13:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:13:53 INFO - 'title': 'talos-linux64-ix-030', 14:13:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:13:53 INFO - 'use_talos_json': True, 14:13:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:13:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:13:53 INFO - 'work_dir': 'build'} 14:13:53 INFO - [mozharness: 2016-12-08 22:13:53.120505Z] Running clobber step. 14:13:53 INFO - Running pre-action listener: _resource_record_pre_action 14:13:53 INFO - Running main action method: clobber 14:13:53 INFO - rmtree: /builds/slave/test/build 14:13:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:13:53 INFO - Running post-action listener: _resource_record_post_action 14:13:53 INFO - [mozharness: 2016-12-08 22:13:53.577278Z] Finished clobber step (success) 14:13:53 INFO - [mozharness: 2016-12-08 22:13:53.577376Z] Running read-buildbot-config step. 14:13:53 INFO - Running pre-action listener: _resource_record_pre_action 14:13:53 INFO - Running main action method: read_buildbot_config 14:13:53 INFO - Using buildbot properties: 14:13:53 INFO - { 14:13:53 INFO - "project": "", 14:13:53 INFO - "product": "firefox", 14:13:53 INFO - "script_repo_revision": "production", 14:13:53 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 14:13:53 INFO - "repository": "", 14:13:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 14:13:53 INFO - "buildid": "20161208141305", 14:13:53 INFO - "stage_platform": "linux64-pgo", 14:13:53 INFO - "basedir": "/builds/slave/test", 14:13:53 INFO - "buildnumber": 2253, 14:13:53 INFO - "platform": "ubuntu64_hw", 14:13:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:13:53 INFO - "slavebuilddir": "test", 14:13:53 INFO - "branch": "mozilla-inbound", 14:13:53 INFO - "revision": "195138298619f5ee4c99dd17df0df98737762a25", 14:13:53 INFO - "slavename": "talos-linux64-ix-030", 14:13:53 INFO - "builduid": "ab8ee06629fb4b20884a49b51ffb7003", 14:13:53 INFO - "repo_path": "integration/mozilla-inbound" 14:13:53 INFO - } 14:13:53 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481229006/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 14:13:53 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481229006/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 14:13:53 INFO - Running post-action listener: _resource_record_post_action 14:13:53 INFO - [mozharness: 2016-12-08 22:13:53.579715Z] Finished read-buildbot-config step (success) 14:13:53 INFO - [mozharness: 2016-12-08 22:13:53.579802Z] Running download-and-extract step. 14:13:53 INFO - Running pre-action listener: _resource_record_pre_action 14:13:53 INFO - Running main action method: download_and_extract 14:13:53 INFO - mkdir: /builds/slave/test/build/tests 14:13:53 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')]} 14:13:53 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481229006/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 14:13:53 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481229006/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 14:13:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481229006/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:13:53 INFO - Downloaded 1361 bytes. 14:13:53 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 14:13:53 INFO - Using the following test package requirements: 14:13:53 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 14:13:53 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:13:53 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:13:53 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:13:53 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:13:53 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:13:53 INFO - u'jsshell-linux-x86_64.zip'], 14:13:53 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:13:53 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:13:53 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 14:13:53 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:13:53 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:13:53 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:13:53 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:13:53 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:13:53 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:13:53 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 14:13:53 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:13:53 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:13:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481229006/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 14:13:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481229006/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:13:53 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481229006/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:13:53 INFO - Expected file size: 21783753 14:13:53 INFO - Obtained file size: 21783753 14:13:57 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:13:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481229006/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 14:13:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481229006/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:13:57 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481229006/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:13:58 INFO - Expected file size: 21783753 14:13:58 INFO - Obtained file size: 21783753 14:14:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481229006/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 14:14:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481229006/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:14:02 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481229006/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 14:14:02 INFO - Expected file size: 14409734 14:14:02 INFO - Obtained file size: 14409734 14:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:03 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481229006/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 14:14:03 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481229006/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 14:14:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481229006/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:14:07 INFO - Downloaded 59847140 bytes. 14:14:07 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481229006/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 14:14:07 INFO - mkdir: /builds/slave/test/properties 14:14:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:14:07 INFO - Writing to file /builds/slave/test/properties/build_url 14:14:07 INFO - Contents: 14:14:07 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481229006/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 14:14:08 INFO - Running post-action listener: _resource_record_post_action 14:14:08 INFO - Running post-action listener: set_extra_try_arguments 14:14:08 INFO - [mozharness: 2016-12-08 22:14:08.369636Z] Finished download-and-extract step (success) 14:14:08 INFO - [mozharness: 2016-12-08 22:14:08.369861Z] Running populate-webroot step. 14:14:08 INFO - Running pre-action listener: _resource_record_pre_action 14:14:08 INFO - Running main action method: populate_webroot 14:14:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:14:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:14:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:14:08 INFO - '--tppagecycles', 14:14:08 INFO - '7'], 14:14:08 INFO - 'tests': ['tsvgm']}}, 14:14:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:14:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:14:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:14:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:14:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:14:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:14:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:14:08 INFO - 'talos_options': ['--disable-e10s'], 14:14:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:14:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:14:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:14:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:14:08 INFO - 'talos_options': ['--disable-e10s'], 14:14:08 INFO - 'tests': ['damp', 'tps']}, 14:14:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:14:08 INFO - 'tests': ['damp', 'tps']}, 14:14:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:14:08 INFO - 'tests': ['dromaeo_dom']}, 14:14:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:14:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:14:08 INFO - 'tests': ['basic_compositor_video']}, 14:14:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:14:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:14:08 INFO - 'tests': ['a11yr', 14:14:08 INFO - 'ts_paint', 14:14:08 INFO - 'tpaint', 14:14:08 INFO - 'sessionrestore', 14:14:08 INFO - 'sessionrestore_no_auto_restore', 14:14:08 INFO - 'tabpaint']}, 14:14:08 INFO - 'other-e10s': {'tests': ['a11yr', 14:14:08 INFO - 'ts_paint', 14:14:08 INFO - 'tpaint', 14:14:08 INFO - 'sessionrestore', 14:14:08 INFO - 'sessionrestore_no_auto_restore', 14:14:08 INFO - 'tabpaint']}, 14:14:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:14:08 INFO - 'ts_paint', 14:14:08 INFO - 'tpaint', 14:14:08 INFO - 'sessionrestore', 14:14:08 INFO - 'sessionrestore_no_auto_restore', 14:14:08 INFO - 'tabpaint']}, 14:14:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:14:08 INFO - 'ts_paint', 14:14:08 INFO - 'tpaint', 14:14:08 INFO - 'sessionrestore', 14:14:08 INFO - 'sessionrestore_no_auto_restore', 14:14:08 INFO - 'tabpaint']}, 14:14:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:14:08 INFO - 'tests': ['a11yr', 14:14:08 INFO - 'ts_paint', 14:14:08 INFO - 'tpaint', 14:14:08 INFO - 'sessionrestore', 14:14:08 INFO - 'sessionrestore_no_auto_restore', 14:14:08 INFO - 'tabpaint']}, 14:14:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:14:08 INFO - 'tests': ['a11yr', 14:14:08 INFO - 'ts_paint', 14:14:08 INFO - 'tpaint', 14:14:08 INFO - 'sessionrestore', 14:14:08 INFO - 'sessionrestore_no_auto_restore', 14:14:08 INFO - 'tabpaint']}, 14:14:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:14:08 INFO - 'tests': ['tsvgx', 14:14:08 INFO - 'tsvgr_opacity', 14:14:08 INFO - 'tart', 14:14:08 INFO - 'tscrollx', 14:14:08 INFO - 'cart', 14:14:08 INFO - 'tsvg_static']}, 14:14:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:14:08 INFO - 'tsvgr_opacity', 14:14:08 INFO - 'tart', 14:14:08 INFO - 'tscrollx', 14:14:08 INFO - 'cart', 14:14:08 INFO - 'tsvg_static']}, 14:14:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:14:08 INFO - 'talos_options': ['--disable-e10s'], 14:14:08 INFO - 'tests': ['tp5o']}, 14:14:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:14:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:14:08 INFO - 'talos_options': ['--disable-e10s', 14:14:08 INFO - '--xperf_path', 14:14:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:14:08 INFO - 'tests': ['tp5n']}, 14:14:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:14:08 INFO - 'talos_options': ['--xperf_path', 14:14:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:14:08 INFO - 'tests': ['tp5n']}}, 14:14:08 INFO - 'talos.zip': {'path': '', 14:14:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:14:08 INFO - Running post-action listener: _resource_record_post_action 14:14:08 INFO - [mozharness: 2016-12-08 22:14:08.389587Z] Finished populate-webroot step (success) 14:14:08 INFO - [mozharness: 2016-12-08 22:14:08.389674Z] Running create-virtualenv step. 14:14:08 INFO - Running pre-action listener: _resource_record_pre_action 14:14:08 INFO - Running main action method: create_virtualenv 14:14:08 INFO - Creating virtualenv /builds/slave/test/build/venv 14:14:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:14:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:14:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:14:08 INFO - Using real prefix '/usr' 14:14:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:14:08 INFO - Installing distribute.............................................................................................................................................................................................done. 14:14:10 INFO - Installing pip.................done. 14:14:10 INFO - Return code: 0 14:14:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:14:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:14:11 INFO - Reading from file tmpfile_stdout 14:14:11 INFO - Output received: 14:14:11 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:14:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08b142be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248c120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251cf20>, '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 0x2489c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2489f90>, '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': '3836458cccd887f2d2de3cf1000001de-1481235231.536358-1396771756', '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 14:14:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:14:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:14:11 INFO - Using env: {'DISPLAY': ':0', 14:14:11 INFO - 'HOME': '/home/cltbld', 14:14:11 INFO - 'LANG': 'en_US.UTF-8', 14:14:11 INFO - 'LANGUAGE': 'en_US:en', 14:14:11 INFO - 'LOGNAME': 'cltbld', 14:14:11 INFO - 'MAIL': '/var/mail/cltbld', 14:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:11 INFO - 'MOZ_NO_REMOTE': '1', 14:14:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:11 INFO - 'NO_EM_RESTART': '1', 14:14:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:11 INFO - 'PWD': '/builds/slave/test', 14:14:11 INFO - 'SHELL': '/bin/bash', 14:14:11 INFO - 'SHLVL': '1', 14:14:11 INFO - 'TERM': 'linux', 14:14:11 INFO - 'TMOUT': '86400', 14:14:11 INFO - 'USER': 'cltbld', 14:14:11 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1481235231.536358-1396771756', 14:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:11 INFO - '_': '/tools/buildbot/bin/python'} 14:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:14:11 INFO - Cleaning up... 14:14:11 INFO - Return code: 0 14:14:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08b142be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248c120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251cf20>, '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 0x2489c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2489f90>, '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': '3836458cccd887f2d2de3cf1000001de-1481235231.536358-1396771756', '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 14:14:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:14:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:14:11 INFO - Using env: {'DISPLAY': ':0', 14:14:11 INFO - 'HOME': '/home/cltbld', 14:14:11 INFO - 'LANG': 'en_US.UTF-8', 14:14:11 INFO - 'LANGUAGE': 'en_US:en', 14:14:11 INFO - 'LOGNAME': 'cltbld', 14:14:11 INFO - 'MAIL': '/var/mail/cltbld', 14:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:11 INFO - 'MOZ_NO_REMOTE': '1', 14:14:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:11 INFO - 'NO_EM_RESTART': '1', 14:14:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:11 INFO - 'PWD': '/builds/slave/test', 14:14:11 INFO - 'SHELL': '/bin/bash', 14:14:11 INFO - 'SHLVL': '1', 14:14:11 INFO - 'TERM': 'linux', 14:14:11 INFO - 'TMOUT': '86400', 14:14:11 INFO - 'USER': 'cltbld', 14:14:11 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1481235231.536358-1396771756', 14:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:11 INFO - '_': '/tools/buildbot/bin/python'} 14:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:11 INFO - Downloading/unpacking psutil>=3.1.1 14:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:14:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:14:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:14:13 INFO - Installing collected packages: psutil 14:14:13 INFO - Running setup.py install for psutil 14:14:13 INFO - building 'psutil._psutil_linux' extension 14:14:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:14:13 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 14:14:13 INFO - building 'psutil._psutil_posix' extension 14:14:13 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 14:14:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:14:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:14:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:14:14 INFO - Successfully installed psutil 14:14:14 INFO - Cleaning up... 14:14:14 INFO - Return code: 0 14:14:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:14:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08b142be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248c120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251cf20>, '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 0x2489c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2489f90>, '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': '3836458cccd887f2d2de3cf1000001de-1481235231.536358-1396771756', '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 14:14:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:14:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:14:14 INFO - Using env: {'DISPLAY': ':0', 14:14:14 INFO - 'HOME': '/home/cltbld', 14:14:14 INFO - 'LANG': 'en_US.UTF-8', 14:14:14 INFO - 'LANGUAGE': 'en_US:en', 14:14:14 INFO - 'LOGNAME': 'cltbld', 14:14:14 INFO - 'MAIL': '/var/mail/cltbld', 14:14:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:14 INFO - 'MOZ_NO_REMOTE': '1', 14:14:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:14 INFO - 'NO_EM_RESTART': '1', 14:14:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:14 INFO - 'PWD': '/builds/slave/test', 14:14:14 INFO - 'SHELL': '/bin/bash', 14:14:14 INFO - 'SHLVL': '1', 14:14:14 INFO - 'TERM': 'linux', 14:14:14 INFO - 'TMOUT': '86400', 14:14:14 INFO - 'USER': 'cltbld', 14:14:14 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1481235231.536358-1396771756', 14:14:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:14 INFO - '_': '/tools/buildbot/bin/python'} 14:14:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:14:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:14:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:14:16 INFO - Installing collected packages: mozsystemmonitor 14:14:16 INFO - Running setup.py install for mozsystemmonitor 14:14:16 INFO - Successfully installed mozsystemmonitor 14:14:16 INFO - Cleaning up... 14:14:16 INFO - Return code: 0 14:14:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:14:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08b142be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248c120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251cf20>, '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 0x2489c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2489f90>, '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': '3836458cccd887f2d2de3cf1000001de-1481235231.536358-1396771756', '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 14:14:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:14:16 INFO - Using env: {'DISPLAY': ':0', 14:14:16 INFO - 'HOME': '/home/cltbld', 14:14:16 INFO - 'LANG': 'en_US.UTF-8', 14:14:16 INFO - 'LANGUAGE': 'en_US:en', 14:14:16 INFO - 'LOGNAME': 'cltbld', 14:14:16 INFO - 'MAIL': '/var/mail/cltbld', 14:14:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:16 INFO - 'MOZ_NO_REMOTE': '1', 14:14:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:16 INFO - 'NO_EM_RESTART': '1', 14:14:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:16 INFO - 'PWD': '/builds/slave/test', 14:14:16 INFO - 'SHELL': '/bin/bash', 14:14:16 INFO - 'SHLVL': '1', 14:14:16 INFO - 'TERM': 'linux', 14:14:16 INFO - 'TMOUT': '86400', 14:14:16 INFO - 'USER': 'cltbld', 14:14:16 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1481235231.536358-1396771756', 14:14:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:16 INFO - '_': '/tools/buildbot/bin/python'} 14:14:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:16 INFO - Downloading/unpacking jsonschema==2.5.1 14:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:14:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:19 INFO - Downloading functools32-3.2.3-2.tar.gz 14:14:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:14:19 INFO - warning: no files found matching '*.txt' 14:14:19 INFO - no previously-included directories found matching 'build' 14:14:19 INFO - no previously-included directories found matching 'dist' 14:14:19 INFO - no previously-included directories found matching '.git*' 14:14:19 INFO - Installing collected packages: jsonschema, functools32 14:14:19 INFO - Running setup.py install for functools32 14:14:19 INFO - warning: no files found matching '*.txt' 14:14:19 INFO - no previously-included directories found matching 'build' 14:14:19 INFO - no previously-included directories found matching 'dist' 14:14:19 INFO - no previously-included directories found matching '.git*' 14:14:19 INFO - Successfully installed jsonschema functools32 14:14:19 INFO - Cleaning up... 14:14:19 INFO - Return code: 0 14:14:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08b142be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248c120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251cf20>, '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 0x2489c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2489f90>, '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': '3836458cccd887f2d2de3cf1000001de-1481235231.536358-1396771756', '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 14:14:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:14:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:14:19 INFO - Using env: {'DISPLAY': ':0', 14:14:19 INFO - 'HOME': '/home/cltbld', 14:14:19 INFO - 'LANG': 'en_US.UTF-8', 14:14:19 INFO - 'LANGUAGE': 'en_US:en', 14:14:19 INFO - 'LOGNAME': 'cltbld', 14:14:19 INFO - 'MAIL': '/var/mail/cltbld', 14:14:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:19 INFO - 'MOZ_NO_REMOTE': '1', 14:14:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:19 INFO - 'NO_EM_RESTART': '1', 14:14:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:19 INFO - 'PWD': '/builds/slave/test', 14:14:19 INFO - 'SHELL': '/bin/bash', 14:14:19 INFO - 'SHLVL': '1', 14:14:19 INFO - 'TERM': 'linux', 14:14:19 INFO - 'TMOUT': '86400', 14:14:19 INFO - 'USER': 'cltbld', 14:14:19 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1481235231.536358-1396771756', 14:14:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:19 INFO - '_': '/tools/buildbot/bin/python'} 14:14:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:14:19 INFO - Cleaning up... 14:14:19 INFO - Return code: 0 14:14:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08b142be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248c120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251cf20>, '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 0x2489c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2489f90>, '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': '3836458cccd887f2d2de3cf1000001de-1481235231.536358-1396771756', '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 14:14:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:14:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:14:19 INFO - Using env: {'DISPLAY': ':0', 14:14:19 INFO - 'HOME': '/home/cltbld', 14:14:19 INFO - 'LANG': 'en_US.UTF-8', 14:14:19 INFO - 'LANGUAGE': 'en_US:en', 14:14:19 INFO - 'LOGNAME': 'cltbld', 14:14:19 INFO - 'MAIL': '/var/mail/cltbld', 14:14:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:19 INFO - 'MOZ_NO_REMOTE': '1', 14:14:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:19 INFO - 'NO_EM_RESTART': '1', 14:14:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:19 INFO - 'PWD': '/builds/slave/test', 14:14:19 INFO - 'SHELL': '/bin/bash', 14:14:19 INFO - 'SHLVL': '1', 14:14:19 INFO - 'TERM': 'linux', 14:14:19 INFO - 'TMOUT': '86400', 14:14:19 INFO - 'USER': 'cltbld', 14:14:19 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1481235231.536358-1396771756', 14:14:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:19 INFO - '_': '/tools/buildbot/bin/python'} 14:14:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:19 INFO - Downloading/unpacking blobuploader==1.2.4 14:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:21 INFO - Downloading blobuploader-1.2.4.tar.gz 14:14:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:14:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:14:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:22 INFO - Downloading docopt-0.6.1.tar.gz 14:14:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:14:22 INFO - Installing collected packages: blobuploader, requests, docopt 14:14:22 INFO - Running setup.py install for blobuploader 14:14:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:14:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:14:22 INFO - Running setup.py install for requests 14:14:22 INFO - Running setup.py install for docopt 14:14:23 INFO - Successfully installed blobuploader requests docopt 14:14:23 INFO - Cleaning up... 14:14:23 INFO - Return code: 0 14:14:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08b142be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248c120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251cf20>, '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 0x2489c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2489f90>, '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': '3836458cccd887f2d2de3cf1000001de-1481235231.536358-1396771756', '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 14:14:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:14:23 INFO - Using env: {'DISPLAY': ':0', 14:14:23 INFO - 'HOME': '/home/cltbld', 14:14:23 INFO - 'LANG': 'en_US.UTF-8', 14:14:23 INFO - 'LANGUAGE': 'en_US:en', 14:14:23 INFO - 'LOGNAME': 'cltbld', 14:14:23 INFO - 'MAIL': '/var/mail/cltbld', 14:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:23 INFO - 'MOZ_NO_REMOTE': '1', 14:14:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:23 INFO - 'NO_EM_RESTART': '1', 14:14:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:23 INFO - 'PWD': '/builds/slave/test', 14:14:23 INFO - 'SHELL': '/bin/bash', 14:14:23 INFO - 'SHLVL': '1', 14:14:23 INFO - 'TERM': 'linux', 14:14:23 INFO - 'TMOUT': '86400', 14:14:23 INFO - 'USER': 'cltbld', 14:14:23 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1481235231.536358-1396771756', 14:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:23 INFO - '_': '/tools/buildbot/bin/python'} 14:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:14:23 INFO - Running setup.py (path:/tmp/pip-TFPH6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:14:23 INFO - Running setup.py (path:/tmp/pip-5pzIQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:14:23 INFO - Running setup.py (path:/tmp/pip-ON2ceQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:14:23 INFO - Running setup.py (path:/tmp/pip-uPL2rq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:14:23 INFO - Running setup.py (path:/tmp/pip-Iw6r2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:14:23 INFO - Running setup.py (path:/tmp/pip-unFfFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:14:23 INFO - Running setup.py (path:/tmp/pip-wCp9hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:14:23 INFO - Running setup.py (path:/tmp/pip-XSJ3Br-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:14:23 INFO - Running setup.py (path:/tmp/pip-X_eESb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:14:23 INFO - Running setup.py (path:/tmp/pip-_9qr8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:14:24 INFO - Running setup.py (path:/tmp/pip-Gi0Rqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:14:24 INFO - Running setup.py (path:/tmp/pip-Zp3Xsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:14:24 INFO - Running setup.py (path:/tmp/pip-iFpyOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:14:24 INFO - Running setup.py (path:/tmp/pip-ZJAvJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:14:24 INFO - Running setup.py (path:/tmp/pip-IyAElz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:14:24 INFO - Running setup.py (path:/tmp/pip-Nw5T37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:14:24 INFO - Running setup.py (path:/tmp/pip-IAkeJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:14:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:14:24 INFO - Running setup.py install for manifestparser 14:14:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:14:24 INFO - Running setup.py install for mozcrash 14:14:24 INFO - Running setup.py install for mozdebug 14:14:24 INFO - Running setup.py install for mozdevice 14:14:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:14:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:14:24 INFO - Running setup.py install for mozfile 14:14:25 INFO - Running setup.py install for mozhttpd 14:14:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:14:25 INFO - Running setup.py install for mozinfo 14:14:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:14:25 INFO - Running setup.py install for mozInstall 14:14:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:14:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:14:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:14:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:14:25 INFO - Running setup.py install for mozleak 14:14:25 INFO - Running setup.py install for mozlog 14:14:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:14:25 INFO - Running setup.py install for moznetwork 14:14:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:14:25 INFO - Running setup.py install for mozprocess 14:14:25 INFO - Running setup.py install for mozprofile 14:14:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:14:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:14:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:14:25 INFO - Running setup.py install for mozrunner 14:14:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:14:26 INFO - Running setup.py install for mozscreenshot 14:14:26 INFO - Running setup.py install for moztest 14:14:26 INFO - Running setup.py install for mozversion 14:14:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:14:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:14:26 INFO - Cleaning up... 14:14:26 INFO - Return code: 0 14:14:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08b142be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248c120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251cf20>, '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 0x2489c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2489f90>, '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': '3836458cccd887f2d2de3cf1000001de-1481235231.536358-1396771756', '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 14:14:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:14:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:14:26 INFO - Using env: {'DISPLAY': ':0', 14:14:26 INFO - 'HOME': '/home/cltbld', 14:14:26 INFO - 'LANG': 'en_US.UTF-8', 14:14:26 INFO - 'LANGUAGE': 'en_US:en', 14:14:26 INFO - 'LOGNAME': 'cltbld', 14:14:26 INFO - 'MAIL': '/var/mail/cltbld', 14:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:26 INFO - 'MOZ_NO_REMOTE': '1', 14:14:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:26 INFO - 'NO_EM_RESTART': '1', 14:14:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:26 INFO - 'PWD': '/builds/slave/test', 14:14:26 INFO - 'SHELL': '/bin/bash', 14:14:26 INFO - 'SHLVL': '1', 14:14:26 INFO - 'TERM': 'linux', 14:14:26 INFO - 'TMOUT': '86400', 14:14:26 INFO - 'USER': 'cltbld', 14:14:26 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1481235231.536358-1396771756', 14:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:26 INFO - '_': '/tools/buildbot/bin/python'} 14:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:14:26 INFO - Running setup.py (path:/tmp/pip-9_rOQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:14:26 INFO - Running setup.py (path:/tmp/pip-IBkYYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 14:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:14:26 INFO - Running setup.py (path:/tmp/pip-LL3rxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:14:26 INFO - Running setup.py (path:/tmp/pip-HKKFvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 14:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:14:26 INFO - Running setup.py (path:/tmp/pip-4SVSlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:14:26 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)) 14:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:14:26 INFO - Running setup.py (path:/tmp/pip-fn26uM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:14:27 INFO - Running setup.py (path:/tmp/pip-yuyu_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:14:27 INFO - Running setup.py (path:/tmp/pip-bvUnUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:14:27 INFO - Running setup.py (path:/tmp/pip-1dVJpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:14:27 INFO - Running setup.py (path:/tmp/pip-QSn9PV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:14:27 INFO - Running setup.py (path:/tmp/pip-BU7zqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:14:27 INFO - Running setup.py (path:/tmp/pip-7utTWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:14:27 INFO - Running setup.py (path:/tmp/pip-sUdVq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:14:27 INFO - Running setup.py (path:/tmp/pip-kXLHs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 14:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:14:27 INFO - Running setup.py (path:/tmp/pip-uDE24B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:14:27 INFO - Running setup.py (path:/tmp/pip-bQ8vwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:14:27 INFO - Running setup.py (path:/tmp/pip-PaNnyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:14:27 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)) 14:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:14:27 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)) 14:14:27 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:14:27 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:14:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:14:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:14:29 INFO - Downloading blessings-1.6.tar.gz 14:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:14:29 INFO - Installing collected packages: blessings 14:14:29 INFO - Running setup.py install for blessings 14:14:30 INFO - Successfully installed blessings 14:14:30 INFO - Cleaning up... 14:14:30 INFO - Return code: 0 14:14:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:14:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:14:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:14:30 INFO - Reading from file tmpfile_stdout 14:14:30 INFO - Current package versions: 14:14:30 INFO - argparse == 1.2.1 14:14:30 INFO - blessings == 1.6 14:14:30 INFO - blobuploader == 1.2.4 14:14:30 INFO - docopt == 0.6.1 14:14:30 INFO - functools32 == 3.2.3-2 14:14:30 INFO - jsonschema == 2.5.1 14:14:30 INFO - manifestparser == 1.1 14:14:30 INFO - mozInstall == 1.12 14:14:30 INFO - mozcrash == 1.0 14:14:30 INFO - mozdebug == 0.1 14:14:30 INFO - mozdevice == 0.49 14:14:30 INFO - mozfile == 1.2 14:14:30 INFO - mozhttpd == 0.7 14:14:30 INFO - mozinfo == 0.9 14:14:30 INFO - mozleak == 0.1 14:14:30 INFO - mozlog == 3.4 14:14:30 INFO - moznetwork == 0.27 14:14:30 INFO - mozprocess == 0.23 14:14:30 INFO - mozprofile == 0.28 14:14:30 INFO - mozrunner == 6.13 14:14:30 INFO - mozscreenshot == 0.1 14:14:30 INFO - mozsystemmonitor == 0.3 14:14:30 INFO - moztest == 0.7 14:14:30 INFO - mozversion == 1.4 14:14:30 INFO - psutil == 3.1.1 14:14:30 INFO - requests == 1.2.3 14:14:30 INFO - wsgiref == 0.1.2 14:14:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08b142be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248c120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251cf20>, '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 0x2489c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2489f90>, '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': '3836458cccd887f2d2de3cf1000001de-1481235231.536358-1396771756', '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 14:14:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:14:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:14:30 INFO - Using env: {'DISPLAY': ':0', 14:14:30 INFO - 'HOME': '/home/cltbld', 14:14:30 INFO - 'LANG': 'en_US.UTF-8', 14:14:30 INFO - 'LANGUAGE': 'en_US:en', 14:14:30 INFO - 'LOGNAME': 'cltbld', 14:14:30 INFO - 'MAIL': '/var/mail/cltbld', 14:14:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:30 INFO - 'MOZ_NO_REMOTE': '1', 14:14:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:30 INFO - 'NO_EM_RESTART': '1', 14:14:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:30 INFO - 'PWD': '/builds/slave/test', 14:14:30 INFO - 'SHELL': '/bin/bash', 14:14:30 INFO - 'SHLVL': '1', 14:14:30 INFO - 'TERM': 'linux', 14:14:30 INFO - 'TMOUT': '86400', 14:14:30 INFO - 'USER': 'cltbld', 14:14:30 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1481235231.536358-1396771756', 14:14:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:30 INFO - '_': '/tools/buildbot/bin/python'} 14:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:14:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:14:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:14:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:14:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:14:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:14:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:14:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:14:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:14:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:14:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:14:30 INFO - Cleaning up... 14:14:30 INFO - Return code: 0 14:14:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08b142be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x248c120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251cf20>, '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 0x2489c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2489f90>, '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': '3836458cccd887f2d2de3cf1000001de-1481235231.536358-1396771756', '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 14:14:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:14:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:14:30 INFO - Using env: {'DISPLAY': ':0', 14:14:30 INFO - 'HOME': '/home/cltbld', 14:14:30 INFO - 'LANG': 'en_US.UTF-8', 14:14:30 INFO - 'LANGUAGE': 'en_US:en', 14:14:30 INFO - 'LOGNAME': 'cltbld', 14:14:30 INFO - 'MAIL': '/var/mail/cltbld', 14:14:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:30 INFO - 'MOZ_NO_REMOTE': '1', 14:14:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:30 INFO - 'NO_EM_RESTART': '1', 14:14:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:30 INFO - 'PWD': '/builds/slave/test', 14:14:30 INFO - 'SHELL': '/bin/bash', 14:14:30 INFO - 'SHLVL': '1', 14:14:30 INFO - 'TERM': 'linux', 14:14:30 INFO - 'TMOUT': '86400', 14:14:30 INFO - 'USER': 'cltbld', 14:14:30 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1481235231.536358-1396771756', 14:14:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:30 INFO - '_': '/tools/buildbot/bin/python'} 14:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:14:30 INFO - Cleaning up... 14:14:30 INFO - Return code: 0 14:14:30 INFO - Running post-action listener: _resource_record_post_action 14:14:30 INFO - Running post-action listener: _start_resource_monitoring 14:14:30 INFO - Starting resource monitoring. 14:14:30 INFO - [mozharness: 2016-12-08 22:14:30.872586Z] Finished create-virtualenv step (success) 14:14:30 INFO - [mozharness: 2016-12-08 22:14:30.873171Z] Running install step. 14:14:30 INFO - Running pre-action listener: _resource_record_pre_action 14:14:30 INFO - Running main action method: install 14:14:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:14:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:14:31 INFO - Reading from file tmpfile_stdout 14:14:31 INFO - Detecting whether we're running mozinstall >=1.0... 14:14:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:14:31 INFO - Reading from file tmpfile_stdout 14:14:31 INFO - Output received: 14:14:31 INFO - Usage: mozinstall [options] installer 14:14:31 INFO - Options: 14:14:31 INFO - -h, --help show this help message and exit 14:14:31 INFO - -d DEST, --destination=DEST 14:14:31 INFO - Directory to install application into. [default: 14:14:31 INFO - "/builds/slave/test"] 14:14:31 INFO - --app=APP Application being installed. [default: firefox] 14:14:31 INFO - mkdir: /builds/slave/test/build/application 14:14:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:14:48 INFO - Reading from file tmpfile_stdout 14:14:48 INFO - Output received: 14:14:48 INFO - /builds/slave/test/build/application/firefox/firefox 14:14:48 INFO - Running post-action listener: _resource_record_post_action 14:14:48 INFO - [mozharness: 2016-12-08 22:14:48.275444Z] Finished install step (success) 14:14:48 INFO - [mozharness: 2016-12-08 22:14:48.275713Z] Running run-tests step. 14:14:48 INFO - Running pre-action listener: _resource_record_pre_action 14:14:48 INFO - Running main action method: run_tests 14:14:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:14:48 INFO - Python 2.7.3 14:14:48 INFO - Return code: 0 14:14:48 INFO - grabbing minidump binary from tooltool 14:14: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')]} 14:14:48 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x251cf20>, '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 0x2489c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2489f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:14:48 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:14:48 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:14:48 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:14:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:14:48 INFO - Return code: 0 14:14:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:14:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:14:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:14:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:14:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:14:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481229006/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 14:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481229006/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 14:14:48 INFO - Using env: {'DISPLAY': ':0', 14:14:48 INFO - 'HOME': '/home/cltbld', 14:14:48 INFO - 'LANG': 'en_US.UTF-8', 14:14:48 INFO - 'LANGUAGE': 'en_US:en', 14:14:48 INFO - 'LOGNAME': 'cltbld', 14:14:48 INFO - 'MAIL': '/var/mail/cltbld', 14:14:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:14:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:48 INFO - 'MOZ_NO_REMOTE': '1', 14:14:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:14:48 INFO - 'NO_EM_RESTART': '1', 14:14:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:48 INFO - 'PWD': '/builds/slave/test', 14:14:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:14:48 INFO - 'SHELL': '/bin/bash', 14:14:48 INFO - 'SHLVL': '1', 14:14:48 INFO - 'TERM': 'linux', 14:14:48 INFO - 'TMOUT': '86400', 14:14:48 INFO - 'USER': 'cltbld', 14:14:48 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1481235231.536358-1396771756', 14:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:48 INFO - '_': '/tools/buildbot/bin/python'} 14:14:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481229006/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 14:14:48 INFO - mozversion application_buildid: 20161208123006 14:14:48 INFO - mozversion application_changeset: 195138298619f5ee4c99dd17df0df98737762a25 14:14:48 INFO - mozversion application_display_name: Nightly 14:14:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:14:48 INFO - mozversion application_name: Firefox 14:14:48 INFO - mozversion application_remotingname: firefox 14:14:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 14:14:48 INFO - mozversion application_vendor: Mozilla 14:14:48 INFO - mozversion application_version: 53.0a1 14:14:48 INFO - mozversion platform_buildid: 20161208123006 14:14:48 INFO - mozversion platform_changeset: 195138298619f5ee4c99dd17df0df98737762a25 14:14:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 14:14:48 INFO - mozversion platform_version: 53.0a1 14:14:48 INFO - using testdate: 1481235288 14:14:48 INFO - actual date: 1481235288 14:14:48 INFO - starting webserver on 'localhost:54287' 14:14:48 INFO - SUITE-START | Running 2 tests 14:14:48 INFO - TEST-START | dromaeo_css 14:14:48 INFO - operating with platform_type : linux_ 14:14:48 INFO - Initialising browser for dromaeo_css test... 14:14:48 INFO - TEST-INFO | started process 28320 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4FxGCr/profile http://localhost:54287/getInfo.html) 14:14:52 INFO - PROCESS | 28320 | __metrics Screen width/height:1600/1200 14:14:52 INFO - PROCESS | 28320 | colorDepth:24 14:14:52 INFO - PROCESS | 28320 | Browser inner width/height: 1024/697 14:14:52 INFO - PROCESS | 28320 | __metrics 14:14:53 INFO - PROCESS | 28320 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:14:53 INFO - PROCESS | 28320 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:14:54 INFO - PROCESS | 28320 | console.error: PushService: 14:14:54 INFO - PROCESS | 28320 | stateChangeProcessEnqueue: Error transitioning state 14:14:54 INFO - PROCESS | 28320 | UnknownError 14:14:54 INFO - TEST-INFO | 28320: exit 0 14:14:54 INFO - Browser initialized. 14:14:54 INFO - Running cycle 1/1 for dromaeo_css test... 14:14:54 INFO - TEST-INFO | started process 28405 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4FxGCr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:15:06 INFO - PROCESS | 28405 | RSS: Main: 172142592 14:15:06 INFO - PROCESS | 28405 | 14:15:58 INFO - PROCESS | 28405 | 1481235358376 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] 14:18:08 INFO - PROCESS | 28405 | Cycle 1(1): loaded http://localhost:54287/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54287/tests/dromaeo/cssquery-ext.html) 14:18:10 INFO - PROCESS | 28405 | RSS: Main: 342085632 14:18:10 INFO - PROCESS | 28405 | 14:21:13 INFO - PROCESS | 28405 | Cycle 1(1): loaded http://localhost:54287/tests/dromaeo/cssquery-ext.html (next: http://localhost:54287/tests/dromaeo/cssquery-jquery.html) 14:21:13 INFO - PROCESS | 28405 | RSS: Main: 277344256 14:21:13 INFO - PROCESS | 28405 | 14:24:15 INFO - PROCESS | 28405 | Cycle 1(1): loaded http://localhost:54287/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54287/tests/dromaeo/cssquery-mootools.html) 14:24:16 INFO - PROCESS | 28405 | RSS: Main: 215969792 14:24:16 INFO - PROCESS | 28405 | 14:27:18 INFO - PROCESS | 28405 | Cycle 1(1): loaded http://localhost:54287/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54287/tests/dromaeo/cssquery-prototype.html) 14:27:19 INFO - PROCESS | 28405 | RSS: Main: 227741696 14:27:19 INFO - PROCESS | 28405 | 14:30:21 INFO - PROCESS | 28405 | Cycle 1(1): loaded http://localhost:54287/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54287/tests/dromaeo/cssquery-yui.html) 14:30:22 INFO - PROCESS | 28405 | RSS: Main: 218501120 14:30:22 INFO - PROCESS | 28405 | 14:33:25 INFO - PROCESS | 28405 | Cycle 1(1): loaded http://localhost:54287/tests/dromaeo/cssquery-yui.html (next: http://localhost:54287/tests/dromaeo/cssquery-dojo.html) 14:33:25 INFO - PROCESS | 28405 | RSS: Main: 310976512 14:33:25 INFO - PROCESS | 28405 | 14:33:25 INFO - PROCESS | 28405 | __start_tp_report 14:33:25 INFO - PROCESS | 28405 | _x_x_mozilla_page_load 14:33:25 INFO - PROCESS | 28405 | _x_x_mozilla_page_load_details 14:33:25 INFO - PROCESS | 28405 | |i|pagename|runs| 14:33:25 INFO - PROCESS | 28405 | |0;dojo.html;3185.331080473102;3221.484562470005;3242.854071566779;3243.7080662740354;3267.55887955126;5247.842564723064;5270.868228294295;5317.867053323659;5341.866453338668;5359.67841929484;5305.151175811871;5342.358916929974;5384.219288203209;5385.946140538594;5407.729613519328;4778.976105119487;4797.352357431754;4824.396950381202;4839.9032019359765;4882.121218180726;4862.270659401082;4870.171812427327;4910.607151427895;4911.45973942866;4945.727984960826;4795.640326975491;4909.3126962225315;4910.263460480956;4935.210366341386;5032.672876263049;4800.879978000543;4829.85510434684;4831.637627177975;4838.927416088762;4866.099771542276;4770.451398089194;4811.951880481185;4829.034193161347;4866.099771542241;4881.974785295092;5308.230306605559;5311.973440132774;5323.30796996388;5328;5335;5523.7790488380415;5570.220169176278;5669.518090962273;5687.573431992617;5688.63023903445;5708.4291570843;5738.340090889559;5758;5765.106408506688;5777.046787280094;5399.352077750656;5399.514043736004;5400.810971615974;5403.054465468527;5403.5136837684795;5671.319441667027;5844.649321040752;5846.29844418664;5848.678322692208;5849.151872978479;5528.44715528444;5548.223248745179;5548.69482178484;5573.526250268773;5624.268845050117;5591.30108736408;5635.126555383922;5637.830865074055;5638.295213098363;5638.464345887216;5626.606137570413;5633.408492108351;5634.5210657093785;5635.351934527582;5639.210510528529;5479.616426850162;5513.972430137824;5584.46947539983;5618.606697531215;5620.437956204429;4340.045190058182;4387.188370151533;4399.692021558524;4401.6478681705385;4404.7357158570585;3907.0427745202605;3929.25344184604;3930.8427662893164;3962.7424217425773;3972.3048466518244;5221.477852214748;5263.657862239019;5321.414644389114;5325.281087053276;5333.439988801198;5605.7197140142825;5609.719514024364;5624.578156638268;5632.549396048306;5701.600887937888;5312.654677445954;5315.202719592092;5315.601329900195;5318.122509785842;5321;4858.489858564871;4860.562549370574;4860.6111511079025;4865.391826021747;4908.509149085135;5696.572757043238;5724.999999999916;5731.340895797037;5733.483986441241;5803.65178089316;5735.56983226268;5751.079827227791;5783.045797443543;5815.563832712479;5852.239208902815;5978.701064946822;5979.431953964367;5989;5990.610610310316;5990.7903223386975;5617.466340697627;5692.288463942007;5692.573057020657;5714.514266287246;5716.885662286814;5621.269234999424;5660;5744.798932037359;5785.450382213683;5790;5696.943030569807;5697.088465845445;5698.316202055614;5702.37273899879;5737.856553586027;5594.608377413542;5599.320203938883;5634.802781902614;5643.52030077448;5680.6591604503865;5439.3200849893765;5487.75305111279;5547.140193270049;5612.074007788832;5622.3815380307315;5645.943540564542;5653.660780353192;5664.207011018543;5695.658260504383;5709.0865461525955;5302.893942121059;5320.866978325573;5328.467153284795;5380.73096345189;5397.082495975615 14:33:25 INFO - PROCESS | 28405 | |1;ext.html;544.2429453607441;602.6594973839779;603.128479347343;626.8589567347344;632.9177206963094;31492.68507314929;34072.31855362891;41008.58991410085;42065;42087.36868946961;43058.56941430585;43434.131317373634;43454.34818477726;43494.34758478625;43508.56491435085;8515.361347898901;8674.262687671524;8677.349198810083;8678.262347700422;8679.826403471927;7735.613219339039;7886.014248218973;8596.441231319975;10046.196304295676;10271.178305735522;10361.89638103617;10422.739431514236;10424;10425.530851111718;10429.895701043006;10290.691279261559;10320.174386049135;10374.948125259401;10382.221333400024;10384;10129.240306976932;10160.542775575117;10173.796524069478;10174.643887463977;10181.236407269484;39914.60085399138;40343;40413.59586404128;40437;40555.59444405577;3196.2968147007623;3253.089135042192;3255.3326568053494;3268.7221586165206;3280.901572952815;30033.849830750707;30105.69894301051;30822;30826.845865770527;30941.381172376652;4105.67154627629;4183.043093933698;4218.240716670998;4230.788460576959;4301.118270754488;306687;306937;309548;310940.99999999773;310960;55019;55317;55362;55397.72301138468;55403;57830.7108464455;57941.130883036785;57958.42041579614;58023;58084;15180.924095379673;15395.846041539666;15398.538043858702;15399.23003849803;15400.614984625474;10719;11809.822852657217;11868.940655296841;11888;11891.524339026342;14573.781393279109;15664.295106720225;15831.287592058385;15943.760843587355;16587.585310367336;5737.139429085671;5834.3290521589715;5894.381089985575;6038.275406951107;6092.817215483543;922.3174850610634;986.31451141456;1001.6344034427382;1028.5782829040206;1125.7804728077947;31732;31926;31989.200269993435;32018;32637.51043734346;1065.6003998500562;1089.5260561655705;1101.7025403141106;1104.7017305327677;1157.6642773595731;15504.612384690246;16697.415590454275;16833.57916052084;16877.32490700383;16939.237734301987;450217;450331;452992;453409;454365;54580.45419545754;54584.454155457934;54679.72660136674;54770.726146369016;54818.72590637101;1227.2268470863478;1250.9061820363509;1251.2117366059324;1340.8122862799216;1347.3128704360652;31371.84314078415;34978.65021349754;35025;35110;35250.294994100484;52401.737991311325;52988.73505632447;53021.73489132529;53031;53060.469395305554;390046;390275;391694;393491;394495;38667.80666096652;39532.60467395289;39592.80203598963;39660;39688.80155599204;34670.65329346674;40033.199336012534;44473.79396635664;48012.27981580209;48908.75545622392;37404.81297593495;38231.426528601536;38620;38634.613653864224;39140.21719565536;38122.618773811904;38424.80787596044;38523;38834.61165388423;39139.21721565496;38943.805280973414;39298.80350598229;39891;40308.39537406882;40455;31374.52938205883;34861.30277394489;35310;35500;35661.82169089138;27387.315317116434;27815.73617449017;27862.582061269502;27863.860680696467;28005.15984520468 14:33:25 INFO - PROCESS | 28405 | |2;jquery.html;373.58345444829007;388.99027524311873;400.6494317472212;406.8433653043578;418.38288524426457;14364.425422983068;15562.221888905566;17449.651006979853;19068.42794716159;19115.139818708158;14646.414143434276;14689.118652880834;16822.915885420585;17105.657886842288;17551.2101955412;5141.22881567765;5392.757325920324;5497.945020549783;5576.5817563682685;5586.022446071942;5527.447255274481;5545.889082218353;5574.442555744434;5577.637453565526;5586.273784408021;5820.35976042635;6039.033754599265;6082.178905847698;6099.57302988791;6104.9389506105035;5660.886782264372;5702.230198923134;6089.238845144357;6101.877962440749;6136.140940268366;5485.314335708036;5517.944820551783;5519.917201241985;5524.779008839641;5525.336959564878;13466.057375983684;15530;21267.46831329214;21691.78308216929;21696.674549881765;2107.1992642795794;2125.521757604542;2217.268301460514;2336.906523739048;2729.9489696467003;9504.809903801885;9847.212223022141;10003.449810260432;10362.740931476697;10497.212709046851;1852.4164888060218;1860.153630098302;1865.1513561329562;1886.3869242496244;1906.8855868647786;70317;75901.62049189775;76196.61901690511;76769.99999999945;77057;10315;10751.569937202581;10760.623378181726;10848.511816968256;10974.396408197626;15203.467878624195;15214.847851521565;15217.695646087017;15222.619434514005;15222.923885380502;6772.153480814898;7087.397571206402;7385.556866588022;7474.065741782278;7768.572728499987;6958.965205174043;7328;7341.559506429631;7453.590052547053;7487.064116985377;4695.389599352063;4703.365045718784;4734.928976065362;4789.688670236424;4845.709257444564;1795.6454136467062;1928.1708865187823;1950.2004178287118;2008.758948926109;2019.3033403475777;807.7092246791151;903.9457632541937;905.3752910491871;936.3726303376754;1016.0855230292796;17711.380101696377;18307.72538411925;18389.26442942294;18556;18835.81164188368;921.0467166482658;959.586639601403;959.8656188133667;965.280865755017;1006.054308949585;10062.333481627375;10409.739756505996;10434.478276086165;10464.895351046393;10487;384268;392039;392087;392431;393135;81282;86012;86135.569322153;86220.56889715511;86574.56712716396;975.2539307429822;997.6707686463595;1027.928045036855;1028.454918892988;1029.0121483375892;15633.609159770642;16113.597160071093;16511.256993435083;16534.255958481655;16644.532979194737;38895.805520972215;39133;39913.60086399215;40165.59834401619;40990.79504602458;51666.741666291426;52457;52477.7376113117;53153.7342313286;53185;7251.673674684546;7493.88759168602;7524.2851929066655;7634.389248859967;7734.806629834299;11913.285202887855;12062.638120856389;12267.631971040882;12280;12598.87401125977;8203;10200.2349823765;10403.479826008821;10633.989770971746;11325.377104259345;10616.89383106159;10651.94674026656;10812.837807432737;10963.177761667748;10974.122070234522;9973.850392244267;10616.1507079435;10784.514696838503;10979.615713449992;11504.654860354203;7939.642716077906;8061.314788243065;8234.423590348619;8380.20388063133;8398.202170793766;8798.736037918872;10866.348019118877;10869.728256793644;10901.34591924487;11080.11359091287 14:33:25 INFO - PROCESS | 28405 | |3;mootools.html;1407.4933024111322;1423.6796720737834;1533.6932613477306;1679.7228457304545;1690.8900921440106;7475.626218689071;7731.110922243944;8122.39082068845;8580.91419085809;8587.828243435135;7665.42509311801;7862.213778622135;7863.488873223251;8057.879131813028;8066.919330806691;2306.700128983234;2345.4488195274184;2347.753485883983;2348.659444380564;2350.6709060731428;2034.6032523657893;2053.650879350514;2276.408133885185;2317.2353123469297;2333.929982100531;2281.7147856517936;2314.594945884472;2317.2932255662017;2371.81025517959;2376.144587948337;2288.5880541502524;2300.2754132448395;2311.6301391777233;2332.2653364190396;2333.6499525071376;2312.976870231293;2313.2944451942153;2330.3242059802637;2332.2536788227776;2346.389938615955;8189.71336003243;8214.055383630899;8250.504969701837;8251.29863961564;8258.59603867344;4957.132501812169;5100.744962751847;5105.923411148836;5110.4634013428795;5121.974390128063;3324.983375083133;3416.8804091856664;3444;3511.929761404783;3562.7684200526883;1069.4332004037872;1124.2636073371955;1147.3976162514664;1189.0903458853984;1200.771853347861;11675.766484670345;11698.707532311675;11771.117166212483;11779.528818847322;11827.94086029573;4346.630536404441;4652.930206046912;4729.810807567659;4812.807487700453;4841.975790121027;9876.555555000043;9881.703548893545;9894.752631184278;9899;9906.950465247628;5156.20078887773;5157.948420515747;5162.406323272797;5162.483751624883;5162.5611822994715;4507.616852567503;4642;4690.015096829704;4694.225452800318;4698.318743782201;3899.473571067926;3954.6045395460224;3990.1620659661794;4009.1179940413062;4076.5515793262716;1192.1178328037363;1203.3441774233063;1303.2506308872246;1330.2750001249342;1330.3880215101162;928.1182876267573;946.3470205558281;946.6639343033262;970.5923512124924;990.1435258501489;5626.97186514073;5632.774689012475;5763.164341170591;5785.797497087666;5989.580729348903;941.23759754599;943.9292053096045;946.9763255918657;952.3619175152664;1006.884208316053;3824.2351529694174;3947.5657677655436;3958.0302825807285;3968.6428221460205;4077.612626800449;10412.323198992193;10469.162467002621;10677.466126693635;10768.946155269174;10792.352458852494;10513.84229236562;10525.684229473129;10580.206484513692;10591.258611897247;10657.573697052187;7896.447248692652;7917.960410197912;7988.281054705104;8088.9595552021865;8122.9187708123345;5688.971555142198;5711.657300561979;5753.280839895013;5779.508741756998;5814.796482123105;9447.763805904633;9558.904410955802;9580.233581313618;9660.32377733552;9745.366551174151;9753;9766.609335626496;9832.852507212254;9890.901090989286;9965.701028969142;6945.444364450933;7052.118485189351;7110.7511237106455;7114.608696521741;7175.605341706257;7895.68417263303;8016.679332826621;8031.879521807061;8035.517868927883;8037.799055023671;7130.251323611154;7232.927670723226;7242.6740796663225;7258.782236532912;7400.703971841066;6932.584044957319;6952.165740111219;7124.643767811485;7151.642417878981;7161.641917903979;6574.276829548841;6599.845027120139;6647.501437392311;6649.434798042221;6656.966715166393;4813.1336359454235;4853.902921941471;4859.562639362474;4885.071836351224;4993.950060499494;4915.410150781929;4953.628477864247;5017.874553136201;5045.394552653705;5176.9741151294 14:33:25 INFO - PROCESS | 28405 | |4;prototype.html;328.28197490573956;339.675609792648;341.7915071806199;345.2215254600878;345.99481007784874;5286.682799032056;5329;5336.466353364657;5338.599605029619;5356.678599284046;4996.725180115092;5079.492050794918;5119.974400128003;5183.429822719498;5289.761960711768;4107.466029416171;4110.424540564323;4115.32097203961;4124.463819703435;4125.711200215986;4103.302438585432;4112.856050038249;4115.259253334399;4118.299889018859;4125.938110928339;3901.31726947783;3951.723379363446;4055.7566546007333;4089.078133277355;4093.1609020150945;4091.8363265469347;4104.712670113093;4105.91788164238;4109.630133287988;4129.174165166964;3649.94525082124;3652.196516766307;3654.7258955578436;3658.32321020612;3660.560732712065;4912.950870491285;5060.519250671217;5103.157978933472;5112;5116.386033675945;4673;4681.602063824579;4681.976590117061;4682.742449165295;4703.835365762182;5422.376426710939;5422.91865622016;5429.592780541436;5447.618666693333;5455.454454554513;3858.4248746957596;4003.2994226010624;4008.198360327946;4018.7588744675413;4021.597840215955;5607.710226647894;5624.887502249932;5630.690312032836;5650.463205995424;5651.434856514356;4051.716379853441;4062.73592216505;4084.243135883267;4093.263212621697;4097.815598298083;4011.13760541485;4125.360569111793;4129.525104612948;4130.545639979599;4135.77253251068;4597.402337696078;4626.722396656144;4635.351050852883;4637.072585482917;4650.604698600657;5448.346198456211;5448.482394172547;5467;5481.808136715275;5493.148561972901;1393.8675825796533;1400.9649758756113;1401.3763875075495;1405.2130806748253;1412.3546068829698;909.8726178335038;932.9020452852488;933.7385532051037;934.780326623243;940.5344354544408;5038.521340472649;5063.594912406998;5088.516590923857;5109.6678715883345;5207.21891716238;5394.78420863169;5405.567554595623;5411.864703382447;5415.296011518556;5437.972810135924;4858.416989961227;5088.847334579968;5107.850733584988;5118.181091025418;5130.1535246684625;2857.5427931530853;2878.913632591026;2879.006742673774;2891.2482754483985;2901.738843504095;5454.945450545444;5604.467575580314;5607.299087614048;5635.859103522363;5643;5432.674039557639;5485.917711234335;5486.588505862076;5492;5509.47659972302;5539.335279766293;5546.417626149277;5570.832875013675;5601.719914004283;5604.6917419541505;5240.2663627093;5364.275822763877;5396.676199428047;5398.703071331114;5431.456854314537;5398.433164517826;5405.756740946588;5406.729663516887;5406.891862162656;5414.972925135507;5485.807996720096;5645.661260324229;5653.943460565341;5662.876421341996;5664.575156863334;3820.6370394812448;3882.902927426837;3902.7853468058393;3923.9019024523473;3944.802759861938;5376.1398176291605;5397.433269506802;5421.5933804964;5470.480304371078;5551.666899986014;5504.669719816824;5506.752196151103;5518.503334699896;5526.889462210653;5541.224228608079;5483.711327838035;5489.917651235155;5504.899020195897;5509.47659972302;5509.889802204014;5297.682139071668;5407.648502847303;5447.564194864322;5458.235846981505;5459.754311055933;5493.725313734218;5509.449055094458;5518.475744804237;5527.39198688152;5527.585431092764;5259.973700131475;5421.349438067457;5425.918611220756;5430.348358196884;5458.208559758892 14:33:25 INFO - PROCESS | 28405 | |5;yui.html;687.4088284075694;698.5389642835723;712.5902606001549;736.5948728199493;793.1473665809257;14543.345549450274;15433.536993890173;15468.22658867055;15492.457763978264;15532.767008494868;14312;14496.492622758205;14557.78163327551;14668.339924703387;14776.926115369408;770.8188575684724;786.5477350523444;787.5510958753513;788.7160622176012;788.8619491588978;662.8144119646506;672.0557616548757;761.2767870522997;779.6062988190955;782.6165179062247;810.1655295046112;823.4071468542639;824.3858325547445;824.7649419915325;824.8309096635205;821.6466919224761;822.2394285286086;822.383212590557;822.8107535266893;823.3084209264186;505.4642079395852;513.5352505982092;603.1947350287371;603.7977277612006;604.2718524178398;13676.726465470634;14134.575962721136;14138.858611413858;14638.048526845827;14638.707225855424;13697.657558561015;13778;14103.78844317336;14238.92880535601;14241.928790356085;12124.818127728091;12169.087318451064;12217.572384966483;12315.5073797048;12442.502299907992;3580.946285805689;3622.873199438033;3695.4826324314618;3701.370766969622;3735.701143908481;74470.62764686196;75142.24857751407;75557.24442755558;75714.94499277975;79038.60480697559;10586.52360643773;10909.781804363869;11185.440727963569;11293.717657058474;11424;21478.24826131078;21608;21616.459588510414;21624.621291657906;21650.24224152147;7820.452568320276;7850.921490785133;7971.8405631887035;8037.316828069563;8105.716299929474;4173.31140361843;4186.66506679471;4189.581041895786;4227.7463352198965;4359.280718681445;3357.9496307555405;3366.360391525602;3375.1055970167927;3381.32373525291;3422.486627005919;568.0882184094552;573.9081746920556;576.6338375131821;576.7462316580775;579.2672269578986;601.2004034633926;607.5838050935124;629.7732816186169;652.1098700274092;663.903733958583;8762.561871906379;8873.467591944504;9002.639894404281;9073.682421115362;9203.217726493323;577.209223363994;612.908063790435;634.0372670807453;648.4002297874447;662.4766434516774;4338;4352;4364.432623758955;4425.800838962255;4516.661250406167;81079.18920810835;81587;82722.58638706768;83930.58034709787;86678.56660716656;59940;61202.69398652978;61886.38113618896;76320.23679763242;80738;59373.70313148493;59496.70251648714;60076;62808.68595656993;63267.36732632707;8788.516631585324;9519.238460923249;9610.471424071744;9666.613335466784;9922.156616687374;44149.77925110354;44318.77840610776;44949.325760114276;44990.550094498634;46763.766181168874;52706.20940685816;54989.450105498436;55772.72113639406;56795.432045679016;57554.71222644027;12258.632241032783;12423.75152496927;12473.750524989631;12850.614481565568;13330.26683532415;13771.39054694217;13813;13884.861151388357;14535.594980700882;14776.926115369355;11920.821187682364;11937.224080434744;12003.279803211835;12180.512779488721;12260.816087758869;11930.697272541227;12169.634910952685;12265.141440099464;12414.937925310316;12713;11668.241564298294;11824.46789894474;11966.760664786829;11997.700057498632;12340.197887137307;10447.68656940293;10653.840192397276;10806.675799726021;10991.06575941054;11269.49287282058;9609.279304052085;10311;10319.845202321821;10323.277370583986;10330.380177189392 14:33:25 INFO - PROCESS | 28405 | __end_tp_report 14:33:25 INFO - PROCESS | 28405 | __start_cc_report 14:33:25 INFO - PROCESS | 28405 | _x_x_mozilla_cycle_collect,1699 14:33:25 INFO - PROCESS | 28405 | __end_cc_report 14:33:25 INFO - PROCESS | 28405 | __startTimestamp1481236405567__endTimestamp 14:33:25 INFO - PROCESS | 28405 | 14:33:25 INFO - PROCESS | 28405 | ------- Summary: start ------- 14:33:25 INFO - PROCESS | 28405 | Number of tests: 6 14:33:25 INFO - PROCESS | 28405 | 14:33:25 INFO - PROCESS | 28405 | [#0] dojo.html Cycles:165 Average:5296.14 Median:5487.75 stddev:577.02 (10.5%) stddev-sans-first:554.52 14:33:25 INFO - PROCESS | 28405 | Values: 3185.3 3221.5 3242.9 3243.7 3267.6 5247.8 5270.9 5317.9 5341.9 5359.7 5305.2 5342.4 5384.2 5385.9 5407.7 4779.0 4797.4 4824.4 4839.9 4882.1 4862.3 4870.2 4910.6 4911.5 4945.7 4795.6 4909.3 4910.3 4935.2 5032.7 4800.9 4829.9 4831.6 4838.9 4866.1 4770.5 4812.0 4829.0 4866.1 4882.0 5308.2 5312.0 5323.3 5328.0 5335.0 5523.8 5570.2 5669.5 5687.6 5688.6 5708.4 5738.3 5758.0 5765.1 5777.0 5399.4 5399.5 5400.8 5403.1 5403.5 5671.3 5844.6 5846.3 5848.7 5849.2 5528.4 5548.2 5548.7 5573.5 5624.3 5591.3 5635.1 5637.8 5638.3 5638.5 5626.6 5633.4 5634.5 5635.4 5639.2 5479.6 5514.0 5584.5 5618.6 5620.4 4340.0 4387.2 4399.7 4401.6 4404.7 3907.0 3929.3 3930.8 3962.7 3972.3 5221.5 5263.7 5321.4 5325.3 5333.4 5605.7 5609.7 5624.6 5632.5 5701.6 5312.7 5315.2 5315.6 5318.1 5321.0 4858.5 4860.6 4860.6 4865.4 4908.5 5696.6 5725.0 5731.3 5733.5 5803.7 5735.6 5751.1 5783.0 5815.6 5852.2 5978.7 5979.4 5989.0 5990.6 5990.8 5617.5 5692.3 5692.6 5714.5 5716.9 5621.3 5660.0 5744.8 5785.5 5790.0 5696.9 5697.1 5698.3 5702.4 5737.9 5594.6 5599.3 5634.8 5643.5 5680.7 5439.3 5487.8 5547.1 5612.1 5622.4 5645.9 5653.7 5664.2 5695.7 5709.1 5302.9 5320.9 5328.5 5380.7 5397.1 14:33:25 INFO - PROCESS | 28405 | 14:33:25 INFO - PROCESS | 28405 | [#1] ext.html Cycles:180 Average:54996.27 Median:38328.12 stddev:102559.17 (267.6%) stddev-sans-first:102765.39 14:33:25 INFO - PROCESS | 28405 | Values: 544.2 602.7 603.1 626.9 632.9 31492.7 34072.3 41008.6 42065.0 42087.4 43058.6 43434.1 43454.3 43494.3 43508.6 8515.4 8674.3 8677.3 8678.3 8679.8 7735.6 7886.0 8596.4 10046.2 10271.2 10361.9 10422.7 10424.0 10425.5 10429.9 10290.7 10320.2 10374.9 10382.2 10384.0 10129.2 10160.5 10173.8 10174.6 10181.2 39914.6 40343.0 40413.6 40437.0 40555.6 3196.3 3253.1 3255.3 3268.7 3280.9 30033.8 30105.7 30822.0 30826.8 30941.4 4105.7 4183.0 4218.2 4230.8 4301.1 306687.0 306937.0 309548.0 310941.0 310960.0 55019.0 55317.0 55362.0 55397.7 55403.0 57830.7 57941.1 57958.4 58023.0 58084.0 15180.9 15395.8 15398.5 15399.2 15400.6 10719.0 11809.8 11868.9 11888.0 11891.5 14573.8 15664.3 15831.3 15943.8 16587.6 5737.1 5834.3 5894.4 6038.3 6092.8 922.3 986.3 1001.6 1028.6 1125.8 31732.0 31926.0 31989.2 32018.0 32637.5 1065.6 1089.5 1101.7 1104.7 1157.7 15504.6 16697.4 16833.6 16877.3 16939.2 450217.0 450331.0 452992.0 453409.0 454365.0 54580.5 54584.5 54679.7 54770.7 54818.7 1227.2 1250.9 1251.2 1340.8 1347.3 31371.8 34978.7 35025.0 35110.0 35250.3 52401.7 52988.7 53021.7 53031.0 53060.5 390046.0 390275.0 391694.0 393491.0 394495.0 38667.8 39532.6 39592.8 39660.0 39688.8 34670.7 40033.2 44473.8 48012.3 48908.8 37404.8 38231.4 38620.0 38634.6 39140.2 38122.6 38424.8 38523.0 38834.6 39139.2 38943.8 39298.8 39891.0 40308.4 40455.0 31374.5 34861.3 35310.0 35500.0 35661.8 27387.3 27815.7 27862.6 27863.9 28005.2 14:33:25 INFO - PROCESS | 28405 | 14:33:25 INFO - PROCESS | 28405 | [#2] jquery.html Cycles:180 Average:25115.17 Median:392063.00 stddev:64820.87 (16.5%) stddev-sans-first:64976.09 14:33:25 INFO - PROCESS | 28405 | Values: 373.6 389.0 400.6 406.8 418.4 14364.4 15562.2 17449.7 19068.4 19115.1 14646.4 14689.1 16822.9 17105.7 17551.2 5141.2 5392.8 5497.9 5576.6 5586.0 5527.4 5545.9 5574.4 5577.6 5586.3 5820.4 6039.0 6082.2 6099.6 6104.9 5660.9 5702.2 6089.2 6101.9 6136.1 5485.3 5517.9 5519.9 5524.8 5525.3 13466.1 15530.0 21267.5 21691.8 21696.7 2107.2 2125.5 2217.3 2336.9 2729.9 9504.8 9847.2 10003.4 10362.7 10497.2 1852.4 1860.2 1865.2 1886.4 1906.9 70317.0 75901.6 76196.6 76770.0 77057.0 10315.0 10751.6 10760.6 10848.5 10974.4 15203.5 15214.8 15217.7 15222.6 15222.9 6772.2 7087.4 7385.6 7474.1 7768.6 6959.0 7328.0 7341.6 7453.6 7487.1 4695.4 4703.4 4734.9 4789.7 4845.7 1795.6 1928.2 1950.2 2008.8 2019.3 807.7 903.9 905.4 936.4 1016.1 17711.4 18307.7 18389.3 18556.0 18835.8 921.0 959.6 959.9 965.3 1006.1 10062.3 10409.7 10434.5 10464.9 10487.0 384268.0 392039.0 392087.0 392431.0 393135.0 81282.0 86012.0 86135.6 86220.6 86574.6 975.3 997.7 1027.9 1028.5 1029.0 15633.6 16113.6 16511.3 16534.3 16644.5 38895.8 39133.0 39913.6 40165.6 40990.8 51666.7 52457.0 52477.7 53153.7 53185.0 7251.7 7493.9 7524.3 7634.4 7734.8 11913.3 12062.6 12267.6 12280.0 12598.9 8203.0 10200.2 10403.5 10634.0 11325.4 10616.9 10651.9 10812.8 10963.2 10974.1 9973.9 10616.2 10784.5 10979.6 11504.7 7939.6 8061.3 8234.4 8380.2 8398.2 8798.7 10866.3 10869.7 10901.3 11080.1 14:33:25 INFO - PROCESS | 28405 | 14:33:25 INFO - PROCESS | 28405 | [#3] mootools.html Cycles:180 Average:5564.15 Median:5073.07 stddev:3101.02 (61.1%) stddev-sans-first:3093.98 14:33:25 INFO - PROCESS | 28405 | Values: 1407.5 1423.7 1533.7 1679.7 1690.9 7475.6 7731.1 8122.4 8580.9 8587.8 7665.4 7862.2 7863.5 8057.9 8066.9 2306.7 2345.4 2347.8 2348.7 2350.7 2034.6 2053.7 2276.4 2317.2 2333.9 2281.7 2314.6 2317.3 2371.8 2376.1 2288.6 2300.3 2311.6 2332.3 2333.6 2313.0 2313.3 2330.3 2332.3 2346.4 8189.7 8214.1 8250.5 8251.3 8258.6 4957.1 5100.7 5105.9 5110.5 5122.0 3325.0 3416.9 3444.0 3511.9 3562.8 1069.4 1124.3 1147.4 1189.1 1200.8 11675.8 11698.7 11771.1 11779.5 11827.9 4346.6 4652.9 4729.8 4812.8 4842.0 9876.6 9881.7 9894.8 9899.0 9907.0 5156.2 5157.9 5162.4 5162.5 5162.6 4507.6 4642.0 4690.0 4694.2 4698.3 3899.5 3954.6 3990.2 4009.1 4076.6 1192.1 1203.3 1303.3 1330.3 1330.4 928.1 946.3 946.7 970.6 990.1 5627.0 5632.8 5763.2 5785.8 5989.6 941.2 943.9 947.0 952.4 1006.9 3824.2 3947.6 3958.0 3968.6 4077.6 10412.3 10469.2 10677.5 10768.9 10792.4 10513.8 10525.7 10580.2 10591.3 10657.6 7896.4 7918.0 7988.3 8089.0 8122.9 5689.0 5711.7 5753.3 5779.5 5814.8 9447.8 9558.9 9580.2 9660.3 9745.4 9753.0 9766.6 9832.9 9890.9 9965.7 6945.4 7052.1 7110.8 7114.6 7175.6 7895.7 8016.7 8031.9 8035.5 8037.8 7130.3 7232.9 7242.7 7258.8 7400.7 6932.6 6952.2 7124.6 7151.6 7161.6 6574.3 6599.8 6647.5 6649.4 6657.0 4813.1 4853.9 4859.6 4885.1 4994.0 4915.4 4953.6 5017.9 5045.4 5177.0 14:33:25 INFO - PROCESS | 28405 | 14:33:25 INFO - PROCESS | 28405 | [#4] prototype.html Cycles:180 Average:4566.94 Median:5273.33 stddev:1319.50 (25.0%) stddev-sans-first:1284.27 14:33:25 INFO - PROCESS | 28405 | Values: 328.3 339.7 341.8 345.2 346.0 5286.7 5329.0 5336.5 5338.6 5356.7 4996.7 5079.5 5120.0 5183.4 5289.8 4107.5 4110.4 4115.3 4124.5 4125.7 4103.3 4112.9 4115.3 4118.3 4125.9 3901.3 3951.7 4055.8 4089.1 4093.2 4091.8 4104.7 4105.9 4109.6 4129.2 3649.9 3652.2 3654.7 3658.3 3660.6 4913.0 5060.5 5103.2 5112.0 5116.4 4673.0 4681.6 4682.0 4682.7 4703.8 5422.4 5422.9 5429.6 5447.6 5455.5 3858.4 4003.3 4008.2 4018.8 4021.6 5607.7 5624.9 5630.7 5650.5 5651.4 4051.7 4062.7 4084.2 4093.3 4097.8 4011.1 4125.4 4129.5 4130.5 4135.8 4597.4 4626.7 4635.4 4637.1 4650.6 5448.3 5448.5 5467.0 5481.8 5493.1 1393.9 1401.0 1401.4 1405.2 1412.4 909.9 932.9 933.7 934.8 940.5 5038.5 5063.6 5088.5 5109.7 5207.2 5394.8 5405.6 5411.9 5415.3 5438.0 4858.4 5088.8 5107.9 5118.2 5130.2 2857.5 2878.9 2879.0 2891.2 2901.7 5454.9 5604.5 5607.3 5635.9 5643.0 5432.7 5485.9 5486.6 5492.0 5509.5 5539.3 5546.4 5570.8 5601.7 5604.7 5240.3 5364.3 5396.7 5398.7 5431.5 5398.4 5405.8 5406.7 5406.9 5415.0 5485.8 5645.7 5653.9 5662.9 5664.6 3820.6 3882.9 3902.8 3923.9 3944.8 5376.1 5397.4 5421.6 5470.5 5551.7 5504.7 5506.8 5518.5 5526.9 5541.2 5483.7 5489.9 5504.9 5509.5 5509.9 5297.7 5407.6 5447.6 5458.2 5459.8 5493.7 5509.4 5518.5 5527.4 5527.6 5260.0 5421.3 5425.9 5430.3 5458.2 14:33:25 INFO - PROCESS | 28405 | 14:33:25 INFO - PROCESS | 28405 | [#5] yui.html Cycles:180 Average:17344.54 Median:44969.94 stddev:22625.48 (50.3%) stddev-sans-first:22654.38 14:33:25 INFO - PROCESS | 28405 | Values: 687.4 698.5 712.6 736.6 793.1 14543.3 15433.5 15468.2 15492.5 15532.8 14312.0 14496.5 14557.8 14668.3 14776.9 770.8 786.5 787.6 788.7 788.9 662.8 672.1 761.3 779.6 782.6 810.2 823.4 824.4 824.8 824.8 821.6 822.2 822.4 822.8 823.3 505.5 513.5 603.2 603.8 604.3 13676.7 14134.6 14138.9 14638.0 14638.7 13697.7 13778.0 14103.8 14238.9 14241.9 12124.8 12169.1 12217.6 12315.5 12442.5 3580.9 3622.9 3695.5 3701.4 3735.7 74470.6 75142.2 75557.2 75714.9 79038.6 10586.5 10909.8 11185.4 11293.7 11424.0 21478.2 21608.0 21616.5 21624.6 21650.2 7820.5 7850.9 7971.8 8037.3 8105.7 4173.3 4186.7 4189.6 4227.7 4359.3 3357.9 3366.4 3375.1 3381.3 3422.5 568.1 573.9 576.6 576.7 579.3 601.2 607.6 629.8 652.1 663.9 8762.6 8873.5 9002.6 9073.7 9203.2 577.2 612.9 634.0 648.4 662.5 4338.0 4352.0 4364.4 4425.8 4516.7 81079.2 81587.0 82722.6 83930.6 86678.6 59940.0 61202.7 61886.4 76320.2 80738.0 59373.7 59496.7 60076.0 62808.7 63267.4 8788.5 9519.2 9610.5 9666.6 9922.2 44149.8 44318.8 44949.3 44990.6 46763.8 52706.2 54989.5 55772.7 56795.4 57554.7 12258.6 12423.8 12473.8 12850.6 13330.3 13771.4 13813.0 13884.9 14535.6 14776.9 11920.8 11937.2 12003.3 12180.5 12260.8 11930.7 12169.6 12265.1 12414.9 12713.0 11668.2 11824.5 11966.8 11997.7 12340.2 10447.7 10653.8 10806.7 10991.1 11269.5 9609.3 10311.0 10319.8 10323.3 10330.4 14:33:25 INFO - PROCESS | 28405 | -------- Summary: end -------- 14:33:25 INFO - PROCESS | 28405 | 14:33:26 INFO - TEST-INFO | 28405: exit 0 14:33:26 INFO - TEST-OK | dromaeo_css | took 1118038ms 14:33:26 INFO - TEST-START | kraken 14:33:26 INFO - operating with platform_type : linux_ 14:33:26 INFO - Initialising browser for kraken test... 14:33:26 INFO - TEST-INFO | started process 28709 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGAn4yr/profile http://localhost:54287/getInfo.html) 14:33:30 INFO - PROCESS | 28709 | __metrics Screen width/height:1600/1200 14:33:30 INFO - PROCESS | 28709 | colorDepth:24 14:33:30 INFO - PROCESS | 28709 | Browser inner width/height: 1024/697 14:33:30 INFO - PROCESS | 28709 | __metrics 14:33:31 INFO - PROCESS | 28709 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:33:31 INFO - PROCESS | 28709 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:33:32 INFO - PROCESS | 28709 | console.error: PushService: 14:33:32 INFO - PROCESS | 28709 | stateChangeProcessEnqueue: Error transitioning state 14:33:32 INFO - PROCESS | 28709 | UnknownError 14:33:32 INFO - TEST-INFO | 28709: exit 0 14:33:32 INFO - Browser initialized. 14:33:32 INFO - Running cycle 1/1 for kraken test... 14:33:32 INFO - TEST-INFO | started process 28795 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGAn4yr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:33:44 INFO - PROCESS | 28795 | RSS: Main: 172384256 14:33:44 INFO - PROCESS | 28795 | 14:33:47 INFO - PROCESS | 28795 | Cycle 1(1): loaded http://localhost:54287/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54287/tests/kraken/driver.html?testName=audio-beat-detection) 14:33:48 INFO - PROCESS | 28795 | RSS: Main: 235106304 14:33:48 INFO - PROCESS | 28795 | 14:33:50 INFO - PROCESS | 28795 | Cycle 1(1): loaded http://localhost:54287/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54287/tests/kraken/driver.html?testName=audio-dft) 14:33:51 INFO - PROCESS | 28795 | RSS: Main: 217227264 14:33:51 INFO - PROCESS | 28795 | 14:33:54 INFO - PROCESS | 28795 | Cycle 1(1): loaded http://localhost:54287/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54287/tests/kraken/driver.html?testName=audio-fft) 14:33:55 INFO - PROCESS | 28795 | RSS: Main: 299384832 14:33:55 INFO - PROCESS | 28795 | 14:33:57 INFO - PROCESS | 28795 | Cycle 1(1): loaded http://localhost:54287/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54287/tests/kraken/driver.html?testName=audio-oscillator) 14:33:57 INFO - PROCESS | 28795 | RSS: Main: 210886656 14:33:57 INFO - PROCESS | 28795 | 14:33:59 INFO - PROCESS | 28795 | Cycle 1(1): loaded http://localhost:54287/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54287/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:34:00 INFO - PROCESS | 28795 | RSS: Main: 214310912 14:34:00 INFO - PROCESS | 28795 | 14:34:03 INFO - PROCESS | 28795 | Cycle 1(1): loaded http://localhost:54287/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54287/tests/kraken/driver.html?testName=imaging-darkroom) 14:34:04 INFO - PROCESS | 28795 | RSS: Main: 252575744 14:34:04 INFO - PROCESS | 28795 | 14:34:07 INFO - PROCESS | 28795 | Cycle 1(1): loaded http://localhost:54287/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54287/tests/kraken/driver.html?testName=imaging-desaturate) 14:34:08 INFO - PROCESS | 28795 | RSS: Main: 252895232 14:34:08 INFO - PROCESS | 28795 | 14:34:10 INFO - PROCESS | 28795 | Cycle 1(1): loaded http://localhost:54287/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54287/tests/kraken/driver.html?testName=json-parse-financial) 14:34:11 INFO - PROCESS | 28795 | RSS: Main: 251994112 14:34:11 INFO - PROCESS | 28795 | 14:34:13 INFO - PROCESS | 28795 | Cycle 1(1): loaded http://localhost:54287/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54287/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:34:13 INFO - PROCESS | 28795 | RSS: Main: 213946368 14:34:13 INFO - PROCESS | 28795 | 14:34:15 INFO - PROCESS | 28795 | Cycle 1(1): loaded http://localhost:54287/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54287/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:34:15 INFO - PROCESS | 28795 | RSS: Main: 221958144 14:34:15 INFO - PROCESS | 28795 | 14:34:18 INFO - PROCESS | 28795 | Cycle 1(1): loaded http://localhost:54287/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54287/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:34:18 INFO - PROCESS | 28795 | RSS: Main: 230240256 14:34:18 INFO - PROCESS | 28795 | 14:34:21 INFO - PROCESS | 28795 | Cycle 1(1): loaded http://localhost:54287/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54287/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:34:22 INFO - PROCESS | 28795 | RSS: Main: 239259648 14:34:22 INFO - PROCESS | 28795 | 14:34:24 INFO - PROCESS | 28795 | Cycle 1(1): loaded http://localhost:54287/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54287/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:34:25 INFO - PROCESS | 28795 | RSS: Main: 236371968 14:34:25 INFO - PROCESS | 28795 | 14:34:27 INFO - PROCESS | 28795 | Cycle 1(1): loaded http://localhost:54287/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54287/tests/kraken/driver.html?testName=ai-astar) 14:34:27 INFO - PROCESS | 28795 | RSS: Main: 286674944 14:34:27 INFO - PROCESS | 28795 | 14:34:27 INFO - PROCESS | 28795 | __start_tp_report 14:34:27 INFO - PROCESS | 28795 | _x_x_mozilla_page_load 14:34:27 INFO - PROCESS | 28795 | _x_x_mozilla_page_load_details 14:34:27 INFO - PROCESS | 28795 | |i|pagename|runs| 14:34:27 INFO - PROCESS | 28795 | |0;ai-astar;105;111;112;110;112;112;113;113;113;112 14:34:27 INFO - PROCESS | 28795 | |1;audio-beat-detection;143;124;123;164;126;127;130;122;145;129 14:34:27 INFO - PROCESS | 28795 | |2;audio-dft;161;161;162;160;162;162;161;161;162;162 14:34:27 INFO - PROCESS | 28795 | |3;audio-fft;75;76;76;122;76;77;75;76;91;76 14:34:27 INFO - PROCESS | 28795 | |4;audio-oscillator;83;83;105;83;83;82;96;83;83;111 14:34:27 INFO - PROCESS | 28795 | |5;imaging-gaussian-blur;116;117;117;116;117;117;117;117;117;117 14:34:27 INFO - PROCESS | 28795 | |6;imaging-darkroom;147;148;147;147;147;147;148;148;146;147 14:34:27 INFO - PROCESS | 28795 | |7;imaging-desaturate;95;95;95;95;95;96;95;100;96;95 14:34:27 INFO - PROCESS | 28795 | |8;json-parse-financial;53;52;53;52;53;54;54;53;53;53 14:34:27 INFO - PROCESS | 28795 | |9;json-stringify-tinderbox;63;63;63;63;64;63;63;63;63;63 14:34:27 INFO - PROCESS | 28795 | |10;stanford-crypto-aes;81;81;81;81;81;82;82;79;81;80 14:34:27 INFO - PROCESS | 28795 | |11;stanford-crypto-ccm;130;141;131;144;141;135;130;127;175;171 14:34:27 INFO - PROCESS | 28795 | |12;stanford-crypto-pbkdf2;164;164;162;172;161;164;167;163;162;167 14:34:27 INFO - PROCESS | 28795 | |13;stanford-crypto-sha256-iterative;65;65;65;65;65;68;64;64;64;65 14:34:27 INFO - PROCESS | 28795 | __end_tp_report 14:34:27 INFO - PROCESS | 28795 | __start_cc_report 14:34:27 INFO - PROCESS | 28795 | _x_x_mozilla_cycle_collect,1665 14:34:27 INFO - PROCESS | 28795 | __end_cc_report 14:34:27 INFO - PROCESS | 28795 | __startTimestamp1481236467343__endTimestamp 14:34:27 INFO - PROCESS | 28795 | 14:34:27 INFO - PROCESS | 28795 | ------- Summary: start ------- 14:34:27 INFO - PROCESS | 28795 | Number of tests: 14 14:34:27 INFO - PROCESS | 28795 | 14:34:27 INFO - PROCESS | 28795 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:2.41 (2.1%) stddev-sans-first:1.00 14:34:27 INFO - PROCESS | 28795 | Values: 105.0 111.0 112.0 110.0 112.0 112.0 113.0 113.0 113.0 112.0 14:34:27 INFO - PROCESS | 28795 | 14:34:27 INFO - PROCESS | 28795 | [#1] audio-beat-detection Cycles:10 Average:133.30 Median:129.50 stddev:13.40 (10.3%) stddev-sans-first:13.75 14:34:27 INFO - PROCESS | 28795 | Values: 143.0 124.0 123.0 164.0 126.0 127.0 130.0 122.0 145.0 129.0 14:34:27 INFO - PROCESS | 28795 | 14:34:27 INFO - PROCESS | 28795 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 14:34:27 INFO - PROCESS | 28795 | Values: 161.0 161.0 162.0 160.0 162.0 162.0 161.0 161.0 162.0 162.0 14:34:27 INFO - PROCESS | 28795 | 14:34:27 INFO - PROCESS | 28795 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:14.85 (19.5%) stddev-sans-first:15.53 14:34:27 INFO - PROCESS | 28795 | Values: 75.0 76.0 76.0 122.0 76.0 77.0 75.0 76.0 91.0 76.0 14:34:27 INFO - PROCESS | 28795 | 14:34:27 INFO - PROCESS | 28795 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:83.00 stddev:10.82 (13.0%) stddev-sans-first:11.24 14:34:27 INFO - PROCESS | 28795 | Values: 83.0 83.0 105.0 83.0 83.0 82.0 96.0 83.0 83.0 111.0 14:34:27 INFO - PROCESS | 28795 | 14:34:27 INFO - PROCESS | 28795 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 14:34:27 INFO - PROCESS | 28795 | Values: 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 14:34:27 INFO - PROCESS | 28795 | 14:34:27 INFO - PROCESS | 28795 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 14:34:27 INFO - PROCESS | 28795 | Values: 147.0 148.0 147.0 147.0 147.0 147.0 148.0 148.0 146.0 147.0 14:34:27 INFO - PROCESS | 28795 | 14:34:27 INFO - PROCESS | 28795 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:95.00 stddev:1.57 (1.6%) stddev-sans-first:1.64 14:34:27 INFO - PROCESS | 28795 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 100.0 96.0 95.0 14:34:27 INFO - PROCESS | 28795 | 14:34:27 INFO - PROCESS | 28795 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:0.67 (1.3%) stddev-sans-first:0.71 14:34:27 INFO - PROCESS | 28795 | Values: 53.0 52.0 53.0 52.0 53.0 54.0 54.0 53.0 53.0 53.0 14:34:27 INFO - PROCESS | 28795 | 14:34:27 INFO - PROCESS | 28795 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 14:34:27 INFO - PROCESS | 28795 | Values: 63.0 63.0 63.0 63.0 64.0 63.0 63.0 63.0 63.0 63.0 14:34:27 INFO - PROCESS | 28795 | 14:34:27 INFO - PROCESS | 28795 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:81.00 stddev:0.88 (1.1%) stddev-sans-first:0.93 14:34:27 INFO - PROCESS | 28795 | Values: 81.0 81.0 81.0 81.0 81.0 82.0 82.0 79.0 81.0 80.0 14:34:27 INFO - PROCESS | 28795 | 14:34:27 INFO - PROCESS | 28795 | [#11] stanford-crypto-ccm Cycles:10 Average:142.50 Median:141.00 stddev:17.05 (12.1%) stddev-sans-first:17.47 14:34:27 INFO - PROCESS | 28795 | Values: 130.0 141.0 131.0 144.0 141.0 135.0 130.0 127.0 175.0 171.0 14:34:27 INFO - PROCESS | 28795 | 14:34:27 INFO - PROCESS | 28795 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.60 Median:164.00 stddev:3.27 (2.0%) stddev-sans-first:3.46 14:34:27 INFO - PROCESS | 28795 | Values: 164.0 164.0 162.0 172.0 161.0 164.0 167.0 163.0 162.0 167.0 14:34:27 INFO - PROCESS | 28795 | 14:34:27 INFO - PROCESS | 28795 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:1.15 (1.8%) stddev-sans-first:1.22 14:34:27 INFO - PROCESS | 28795 | Values: 65.0 65.0 65.0 65.0 65.0 68.0 64.0 64.0 64.0 65.0 14:34:27 INFO - PROCESS | 28795 | -------- Summary: end -------- 14:34:27 INFO - PROCESS | 28795 | 14:34:28 INFO - TEST-INFO | 28795: exit 0 14:34:28 INFO - TEST-OK | kraken | took 61990ms 14:34:28 INFO - SUITE-END | took 1180s 14:34:29 INFO - Completed test suite (00:19:40) 14:34:29 INFO - javascript benchmark 14:34:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3185.331080473102, 3221.484562470005, 3242.854071566779, 3243.7080662740354, 3267.55887955126, 5247.842564723064, 5270.868228294295, 5317.867053323659, 5341.866453338668, 5359.67841929484, 5305.151175811871, 5342.358916929974, 5384.219288203209, 5385.946140538594, 5407.729613519328, 4778.976105119487, 4797.352357431754, 4824.396950381202, 4839.9032019359765, 4882.121218180726, 4862.270659401082, 4870.171812427327, 4910.607151427895, 4911.45973942866, 4945.727984960826, 4795.640326975491, 4909.3126962225315, 4910.263460480956, 4935.210366341386, 5032.672876263049, 4800.879978000543, 4829.85510434684, 4831.637627177975, 4838.927416088762, 4866.099771542276, 4770.451398089194, 4811.951880481185, 4829.034193161347, 4866.099771542241, 4881.974785295092, 5308.230306605559, 5311.973440132774, 5323.30796996388, 5328.0, 5335.0, 5523.7790488380415, 5570.220169176278, 5669.518090962273, 5687.573431992617, 5688.63023903445, 5708.4291570843, 5738.340090889559, 5758.0, 5765.106408506688, 5777.046787280094, 5399.352077750656, 5399.514043736004, 5400.810971615974, 5403.054465468527, 5403.5136837684795, 5671.319441667027, 5844.649321040752, 5846.29844418664, 5848.678322692208, 5849.151872978479, 5528.44715528444, 5548.223248745179, 5548.69482178484, 5573.526250268773, 5624.268845050117, 5591.30108736408, 5635.126555383922, 5637.830865074055, 5638.295213098363, 5638.464345887216, 5626.606137570413, 5633.408492108351, 5634.5210657093785, 5635.351934527582, 5639.210510528529, 5479.616426850162, 5513.972430137824, 5584.46947539983, 5618.606697531215, 5620.437956204429, 4340.045190058182, 4387.188370151533, 4399.692021558524, 4401.6478681705385, 4404.7357158570585, 3907.0427745202605, 3929.25344184604, 3930.8427662893164, 3962.7424217425773, 3972.3048466518244, 5221.477852214748, 5263.657862239019, 5321.414644389114, 5325.281087053276, 5333.439988801198, 5605.7197140142825, 5609.719514024364, 5624.578156638268, 5632.549396048306, 5701.600887937888, 5312.654677445954, 5315.202719592092, 5315.601329900195, 5318.122509785842, 5321.0, 4858.489858564871, 4860.562549370574, 4860.6111511079025, 4865.391826021747, 4908.509149085135, 5696.572757043238, 5724.999999999916, 5731.340895797037, 5733.483986441241, 5803.65178089316, 5735.56983226268, 5751.079827227791, 5783.045797443543, 5815.563832712479, 5852.239208902815, 5978.701064946822, 5979.431953964367, 5989.0, 5990.610610310316, 5990.7903223386975, 5617.466340697627, 5692.288463942007, 5692.573057020657, 5714.514266287246, 5716.885662286814, 5621.269234999424, 5660.0, 5744.798932037359, 5785.450382213683, 5790.0, 5696.943030569807, 5697.088465845445, 5698.316202055614, 5702.37273899879, 5737.856553586027, 5594.608377413542, 5599.320203938883, 5634.802781902614, 5643.52030077448, 5680.6591604503865, 5439.3200849893765, 5487.75305111279, 5547.140193270049, 5612.074007788832, 5622.3815380307315, 5645.943540564542, 5653.660780353192, 5664.207011018543, 5695.658260504383, 5709.0865461525955, 5302.893942121059, 5320.866978325573, 5328.467153284795, 5380.73096345189, 5397.082495975615], "value": 5259.461478989627, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.2429453607441, 602.6594973839779, 603.128479347343, 626.8589567347344, 632.9177206963094, 31492.68507314929, 34072.31855362891, 41008.58991410085, 42065.0, 42087.36868946961, 43058.56941430585, 43434.131317373634, 43454.34818477726, 43494.34758478625, 43508.56491435085, 8515.361347898901, 8674.262687671524, 8677.349198810083, 8678.262347700422, 8679.826403471927, 7735.613219339039, 7886.014248218973, 8596.441231319975, 10046.196304295676, 10271.178305735522, 10361.89638103617, 10422.739431514236, 10424.0, 10425.530851111718, 10429.895701043006, 10290.691279261559, 10320.174386049135, 10374.948125259401, 10382.221333400024, 10384.0, 10129.240306976932, 10160.542775575117, 10173.796524069478, 10174.643887463977, 10181.236407269484, 39914.60085399138, 40343.0, 40413.59586404128, 40437.0, 40555.59444405577, 3196.2968147007623, 3253.089135042192, 3255.3326568053494, 3268.7221586165206, 3280.901572952815, 30033.849830750707, 30105.69894301051, 30822.0, 30826.845865770527, 30941.381172376652, 4105.67154627629, 4183.043093933698, 4218.240716670998, 4230.788460576959, 4301.118270754488, 306687.0, 306937.0, 309548.0, 310940.99999999773, 310960.0, 55019.0, 55317.0, 55362.0, 55397.72301138468, 55403.0, 57830.7108464455, 57941.130883036785, 57958.42041579614, 58023.0, 58084.0, 15180.924095379673, 15395.846041539666, 15398.538043858702, 15399.23003849803, 15400.614984625474, 10719.0, 11809.822852657217, 11868.940655296841, 11888.0, 11891.524339026342, 14573.781393279109, 15664.295106720225, 15831.287592058385, 15943.760843587355, 16587.585310367336, 5737.139429085671, 5834.3290521589715, 5894.381089985575, 6038.275406951107, 6092.817215483543, 922.3174850610634, 986.31451141456, 1001.6344034427382, 1028.5782829040206, 1125.7804728077947, 31732.0, 31926.0, 31989.200269993435, 32018.0, 32637.51043734346, 1065.6003998500562, 1089.5260561655705, 1101.7025403141106, 1104.7017305327677, 1157.6642773595731, 15504.612384690246, 16697.415590454275, 16833.57916052084, 16877.32490700383, 16939.237734301987, 450217.0, 450331.0, 452992.0, 453409.0, 454365.0, 54580.45419545754, 54584.454155457934, 54679.72660136674, 54770.726146369016, 54818.72590637101, 1227.2268470863478, 1250.9061820363509, 1251.2117366059324, 1340.8122862799216, 1347.3128704360652, 31371.84314078415, 34978.65021349754, 35025.0, 35110.0, 35250.294994100484, 52401.737991311325, 52988.73505632447, 53021.73489132529, 53031.0, 53060.469395305554, 390046.0, 390275.0, 391694.0, 393491.0, 394495.0, 38667.80666096652, 39532.60467395289, 39592.80203598963, 39660.0, 39688.80155599204, 34670.65329346674, 40033.199336012534, 44473.79396635664, 48012.27981580209, 48908.75545622392, 37404.81297593495, 38231.426528601536, 38620.0, 38634.613653864224, 39140.21719565536, 38122.618773811904, 38424.80787596044, 38523.0, 38834.61165388423, 39139.21721565496, 38943.805280973414, 39298.80350598229, 39891.0, 40308.39537406882, 40455.0, 31374.52938205883, 34861.30277394489, 35310.0, 35500.0, 35661.82169089138, 27387.315317116434, 27815.73617449017, 27862.582061269502, 27863.860680696467, 28005.15984520468], "value": 19551.19941737114, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.58345444829007, 388.99027524311873, 400.6494317472212, 406.8433653043578, 418.38288524426457, 14364.425422983068, 15562.221888905566, 17449.651006979853, 19068.42794716159, 19115.139818708158, 14646.414143434276, 14689.118652880834, 16822.915885420585, 17105.657886842288, 17551.2101955412, 5141.22881567765, 5392.757325920324, 5497.945020549783, 5576.5817563682685, 5586.022446071942, 5527.447255274481, 5545.889082218353, 5574.442555744434, 5577.637453565526, 5586.273784408021, 5820.35976042635, 6039.033754599265, 6082.178905847698, 6099.57302988791, 6104.9389506105035, 5660.886782264372, 5702.230198923134, 6089.238845144357, 6101.877962440749, 6136.140940268366, 5485.314335708036, 5517.944820551783, 5519.917201241985, 5524.779008839641, 5525.336959564878, 13466.057375983684, 15530.0, 21267.46831329214, 21691.78308216929, 21696.674549881765, 2107.1992642795794, 2125.521757604542, 2217.268301460514, 2336.906523739048, 2729.9489696467003, 9504.809903801885, 9847.212223022141, 10003.449810260432, 10362.740931476697, 10497.212709046851, 1852.4164888060218, 1860.153630098302, 1865.1513561329562, 1886.3869242496244, 1906.8855868647786, 70317.0, 75901.62049189775, 76196.61901690511, 76769.99999999945, 77057.0, 10315.0, 10751.569937202581, 10760.623378181726, 10848.511816968256, 10974.396408197626, 15203.467878624195, 15214.847851521565, 15217.695646087017, 15222.619434514005, 15222.923885380502, 6772.153480814898, 7087.397571206402, 7385.556866588022, 7474.065741782278, 7768.572728499987, 6958.965205174043, 7328.0, 7341.559506429631, 7453.590052547053, 7487.064116985377, 4695.389599352063, 4703.365045718784, 4734.928976065362, 4789.688670236424, 4845.709257444564, 1795.6454136467062, 1928.1708865187823, 1950.2004178287118, 2008.758948926109, 2019.3033403475777, 807.7092246791151, 903.9457632541937, 905.3752910491871, 936.3726303376754, 1016.0855230292796, 17711.380101696377, 18307.72538411925, 18389.26442942294, 18556.0, 18835.81164188368, 921.0467166482658, 959.586639601403, 959.8656188133667, 965.280865755017, 1006.054308949585, 10062.333481627375, 10409.739756505996, 10434.478276086165, 10464.895351046393, 10487.0, 384268.0, 392039.0, 392087.0, 392431.0, 393135.0, 81282.0, 86012.0, 86135.569322153, 86220.56889715511, 86574.56712716396, 975.2539307429822, 997.6707686463595, 1027.928045036855, 1028.454918892988, 1029.0121483375892, 15633.609159770642, 16113.597160071093, 16511.256993435083, 16534.255958481655, 16644.532979194737, 38895.805520972215, 39133.0, 39913.60086399215, 40165.59834401619, 40990.79504602458, 51666.741666291426, 52457.0, 52477.7376113117, 53153.7342313286, 53185.0, 7251.673674684546, 7493.88759168602, 7524.2851929066655, 7634.389248859967, 7734.806629834299, 11913.285202887855, 12062.638120856389, 12267.631971040882, 12280.0, 12598.87401125977, 8203.0, 10200.2349823765, 10403.479826008821, 10633.989770971746, 11325.377104259345, 10616.89383106159, 10651.94674026656, 10812.837807432737, 10963.177761667748, 10974.122070234522, 9973.850392244267, 10616.1507079435, 10784.514696838503, 10979.615713449992, 11504.654860354203, 7939.642716077906, 8061.314788243065, 8234.423590348619, 8380.20388063133, 8398.202170793766, 8798.736037918872, 10866.348019118877, 10869.728256793644, 10901.34591924487, 11080.11359091287], "value": 8669.298775086461, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1407.4933024111322, 1423.6796720737834, 1533.6932613477306, 1679.7228457304545, 1690.8900921440106, 7475.626218689071, 7731.110922243944, 8122.39082068845, 8580.91419085809, 8587.828243435135, 7665.42509311801, 7862.213778622135, 7863.488873223251, 8057.879131813028, 8066.919330806691, 2306.700128983234, 2345.4488195274184, 2347.753485883983, 2348.659444380564, 2350.6709060731428, 2034.6032523657893, 2053.650879350514, 2276.408133885185, 2317.2353123469297, 2333.929982100531, 2281.7147856517936, 2314.594945884472, 2317.2932255662017, 2371.81025517959, 2376.144587948337, 2288.5880541502524, 2300.2754132448395, 2311.6301391777233, 2332.2653364190396, 2333.6499525071376, 2312.976870231293, 2313.2944451942153, 2330.3242059802637, 2332.2536788227776, 2346.389938615955, 8189.71336003243, 8214.055383630899, 8250.504969701837, 8251.29863961564, 8258.59603867344, 4957.132501812169, 5100.744962751847, 5105.923411148836, 5110.4634013428795, 5121.974390128063, 3324.983375083133, 3416.8804091856664, 3444.0, 3511.929761404783, 3562.7684200526883, 1069.4332004037872, 1124.2636073371955, 1147.3976162514664, 1189.0903458853984, 1200.771853347861, 11675.766484670345, 11698.707532311675, 11771.117166212483, 11779.528818847322, 11827.94086029573, 4346.630536404441, 4652.930206046912, 4729.810807567659, 4812.807487700453, 4841.975790121027, 9876.555555000043, 9881.703548893545, 9894.752631184278, 9899.0, 9906.950465247628, 5156.20078887773, 5157.948420515747, 5162.406323272797, 5162.483751624883, 5162.5611822994715, 4507.616852567503, 4642.0, 4690.015096829704, 4694.225452800318, 4698.318743782201, 3899.473571067926, 3954.6045395460224, 3990.1620659661794, 4009.1179940413062, 4076.5515793262716, 1192.1178328037363, 1203.3441774233063, 1303.2506308872246, 1330.2750001249342, 1330.3880215101162, 928.1182876267573, 946.3470205558281, 946.6639343033262, 970.5923512124924, 990.1435258501489, 5626.97186514073, 5632.774689012475, 5763.164341170591, 5785.797497087666, 5989.580729348903, 941.23759754599, 943.9292053096045, 946.9763255918657, 952.3619175152664, 1006.884208316053, 3824.2351529694174, 3947.5657677655436, 3958.0302825807285, 3968.6428221460205, 4077.612626800449, 10412.323198992193, 10469.162467002621, 10677.466126693635, 10768.946155269174, 10792.352458852494, 10513.84229236562, 10525.684229473129, 10580.206484513692, 10591.258611897247, 10657.573697052187, 7896.447248692652, 7917.960410197912, 7988.281054705104, 8088.9595552021865, 8122.9187708123345, 5688.971555142198, 5711.657300561979, 5753.280839895013, 5779.508741756998, 5814.796482123105, 9447.763805904633, 9558.904410955802, 9580.233581313618, 9660.32377733552, 9745.366551174151, 9753.0, 9766.609335626496, 9832.852507212254, 9890.901090989286, 9965.701028969142, 6945.444364450933, 7052.118485189351, 7110.7511237106455, 7114.608696521741, 7175.605341706257, 7895.68417263303, 8016.679332826621, 8031.879521807061, 8035.517868927883, 8037.799055023671, 7130.251323611154, 7232.927670723226, 7242.6740796663225, 7258.782236532912, 7400.703971841066, 6932.584044957319, 6952.165740111219, 7124.643767811485, 7151.642417878981, 7161.641917903979, 6574.276829548841, 6599.845027120139, 6647.501437392311, 6649.434798042221, 6656.966715166393, 4813.1336359454235, 4853.902921941471, 4859.562639362474, 4885.071836351224, 4993.950060499494, 4915.410150781929, 4953.628477864247, 5017.874553136201, 5045.394552653705, 5176.9741151294], "value": 4503.743096991383, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.28197490573956, 339.675609792648, 341.7915071806199, 345.2215254600878, 345.99481007784874, 5286.682799032056, 5329.0, 5336.466353364657, 5338.599605029619, 5356.678599284046, 4996.725180115092, 5079.492050794918, 5119.974400128003, 5183.429822719498, 5289.761960711768, 4107.466029416171, 4110.424540564323, 4115.32097203961, 4124.463819703435, 4125.711200215986, 4103.302438585432, 4112.856050038249, 4115.259253334399, 4118.299889018859, 4125.938110928339, 3901.31726947783, 3951.723379363446, 4055.7566546007333, 4089.078133277355, 4093.1609020150945, 4091.8363265469347, 4104.712670113093, 4105.91788164238, 4109.630133287988, 4129.174165166964, 3649.94525082124, 3652.196516766307, 3654.7258955578436, 3658.32321020612, 3660.560732712065, 4912.950870491285, 5060.519250671217, 5103.157978933472, 5112.0, 5116.386033675945, 4673.0, 4681.602063824579, 4681.976590117061, 4682.742449165295, 4703.835365762182, 5422.376426710939, 5422.91865622016, 5429.592780541436, 5447.618666693333, 5455.454454554513, 3858.4248746957596, 4003.2994226010624, 4008.198360327946, 4018.7588744675413, 4021.597840215955, 5607.710226647894, 5624.887502249932, 5630.690312032836, 5650.463205995424, 5651.434856514356, 4051.716379853441, 4062.73592216505, 4084.243135883267, 4093.263212621697, 4097.815598298083, 4011.13760541485, 4125.360569111793, 4129.525104612948, 4130.545639979599, 4135.77253251068, 4597.402337696078, 4626.722396656144, 4635.351050852883, 4637.072585482917, 4650.604698600657, 5448.346198456211, 5448.482394172547, 5467.0, 5481.808136715275, 5493.148561972901, 1393.8675825796533, 1400.9649758756113, 1401.3763875075495, 1405.2130806748253, 1412.3546068829698, 909.8726178335038, 932.9020452852488, 933.7385532051037, 934.780326623243, 940.5344354544408, 5038.521340472649, 5063.594912406998, 5088.516590923857, 5109.6678715883345, 5207.21891716238, 5394.78420863169, 5405.567554595623, 5411.864703382447, 5415.296011518556, 5437.972810135924, 4858.416989961227, 5088.847334579968, 5107.850733584988, 5118.181091025418, 5130.1535246684625, 2857.5427931530853, 2878.913632591026, 2879.006742673774, 2891.2482754483985, 2901.738843504095, 5454.945450545444, 5604.467575580314, 5607.299087614048, 5635.859103522363, 5643.0, 5432.674039557639, 5485.917711234335, 5486.588505862076, 5492.0, 5509.47659972302, 5539.335279766293, 5546.417626149277, 5570.832875013675, 5601.719914004283, 5604.6917419541505, 5240.2663627093, 5364.275822763877, 5396.676199428047, 5398.703071331114, 5431.456854314537, 5398.433164517826, 5405.756740946588, 5406.729663516887, 5406.891862162656, 5414.972925135507, 5485.807996720096, 5645.661260324229, 5653.943460565341, 5662.876421341996, 5664.575156863334, 3820.6370394812448, 3882.902927426837, 3902.7853468058393, 3923.9019024523473, 3944.802759861938, 5376.1398176291605, 5397.433269506802, 5421.5933804964, 5470.480304371078, 5551.666899986014, 5504.669719816824, 5506.752196151103, 5518.503334699896, 5526.889462210653, 5541.224228608079, 5483.711327838035, 5489.917651235155, 5504.899020195897, 5509.47659972302, 5509.889802204014, 5297.682139071668, 5407.648502847303, 5447.564194864322, 5458.235846981505, 5459.754311055933, 5493.725313734218, 5509.449055094458, 5518.475744804237, 5527.39198688152, 5527.585431092764, 5259.973700131475, 5421.349438067457, 5425.918611220756, 5430.348358196884, 5458.208559758892], "value": 4149.919468271724, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.4088284075694, 698.5389642835723, 712.5902606001549, 736.5948728199493, 793.1473665809257, 14543.345549450274, 15433.536993890173, 15468.22658867055, 15492.457763978264, 15532.767008494868, 14312.0, 14496.492622758205, 14557.78163327551, 14668.339924703387, 14776.926115369408, 770.8188575684724, 786.5477350523444, 787.5510958753513, 788.7160622176012, 788.8619491588978, 662.8144119646506, 672.0557616548757, 761.2767870522997, 779.6062988190955, 782.6165179062247, 810.1655295046112, 823.4071468542639, 824.3858325547445, 824.7649419915325, 824.8309096635205, 821.6466919224761, 822.2394285286086, 822.383212590557, 822.8107535266893, 823.3084209264186, 505.4642079395852, 513.5352505982092, 603.1947350287371, 603.7977277612006, 604.2718524178398, 13676.726465470634, 14134.575962721136, 14138.858611413858, 14638.048526845827, 14638.707225855424, 13697.657558561015, 13778.0, 14103.78844317336, 14238.92880535601, 14241.928790356085, 12124.818127728091, 12169.087318451064, 12217.572384966483, 12315.5073797048, 12442.502299907992, 3580.946285805689, 3622.873199438033, 3695.4826324314618, 3701.370766969622, 3735.701143908481, 74470.62764686196, 75142.24857751407, 75557.24442755558, 75714.94499277975, 79038.60480697559, 10586.52360643773, 10909.781804363869, 11185.440727963569, 11293.717657058474, 11424.0, 21478.24826131078, 21608.0, 21616.459588510414, 21624.621291657906, 21650.24224152147, 7820.452568320276, 7850.921490785133, 7971.8405631887035, 8037.316828069563, 8105.716299929474, 4173.31140361843, 4186.66506679471, 4189.581041895786, 4227.7463352198965, 4359.280718681445, 3357.9496307555405, 3366.360391525602, 3375.1055970167927, 3381.32373525291, 3422.486627005919, 568.0882184094552, 573.9081746920556, 576.6338375131821, 576.7462316580775, 579.2672269578986, 601.2004034633926, 607.5838050935124, 629.7732816186169, 652.1098700274092, 663.903733958583, 8762.561871906379, 8873.467591944504, 9002.639894404281, 9073.682421115362, 9203.217726493323, 577.209223363994, 612.908063790435, 634.0372670807453, 648.4002297874447, 662.4766434516774, 4338.0, 4352.0, 4364.432623758955, 4425.800838962255, 4516.661250406167, 81079.18920810835, 81587.0, 82722.58638706768, 83930.58034709787, 86678.56660716656, 59940.0, 61202.69398652978, 61886.38113618896, 76320.23679763242, 80738.0, 59373.70313148493, 59496.70251648714, 60076.0, 62808.68595656993, 63267.36732632707, 8788.516631585324, 9519.238460923249, 9610.471424071744, 9666.613335466784, 9922.156616687374, 44149.77925110354, 44318.77840610776, 44949.325760114276, 44990.550094498634, 46763.766181168874, 52706.20940685816, 54989.450105498436, 55772.72113639406, 56795.432045679016, 57554.71222644027, 12258.632241032783, 12423.75152496927, 12473.750524989631, 12850.614481565568, 13330.26683532415, 13771.39054694217, 13813.0, 13884.861151388357, 14535.594980700882, 14776.926115369355, 11920.821187682364, 11937.224080434744, 12003.279803211835, 12180.512779488721, 12260.816087758869, 11930.697272541227, 12169.634910952685, 12265.141440099464, 12414.937925310316, 12713.0, 11668.241564298294, 11824.46789894474, 11966.760664786829, 11997.700057498632, 12340.197887137307, 10447.68656940293, 10653.840192397276, 10806.675799726021, 10991.06575941054, 11269.49287282058, 9609.279304052085, 10311.0, 10319.845202321821, 10323.277370583986, 10330.380177189392], "value": 6916.42325265271, "unit": "score"}], "name": "dromaeo_css", "value": 6975.999662294332, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 112.0, 110.0, 112.0, 112.0, 113.0, 113.0, 113.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 124.0, 123.0, 164.0, 126.0, 127.0, 130.0, 122.0, 145.0, 129.0], "value": 133.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 160.0, 162.0, 162.0, 161.0, 161.0, 162.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 122.0, 76.0, 77.0, 75.0, 76.0, 91.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 105.0, 83.0, 83.0, 82.0, 96.0, 83.0, 83.0, 111.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0, 146.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 100.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 52.0, 53.0, 54.0, 54.0, 53.0, 53.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 81.0, 81.0, 81.0, 82.0, 82.0, 79.0, 81.0, 80.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 141.0, 131.0, 144.0, 141.0, 135.0, 130.0, 127.0, 175.0, 171.0], "value": 142.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 162.0, 172.0, 161.0, 164.0, 167.0, 163.0, 162.0, 167.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 68.0, 64.0, 64.0, 64.0, 65.0], "value": 65.0, "unit": "score"}], "name": "kraken", "value": 1506.0, "alertThreshold": 2.0}]} 14:34:29 INFO - Return code: 0 14:34:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:34:29 INFO - # TBPL SUCCESS # 14:34:29 INFO - Running post-action listener: _resource_record_post_action 14:34:29 INFO - [mozharness: 2016-12-08 22:34:29.167640Z] Finished run-tests step (success) 14:34:29 INFO - Running post-run listener: _resource_record_post_run 14:34:29 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 392351744; Read time: 0; Write time: 302812 14:34:29 INFO - TinderboxPrint: CPU usage
13.2% 14:34:29 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 14:34:29 INFO - TinderboxPrint: I/O write bytes / time
392,351,744 / 302,812 14:34:29 INFO - TinderboxPrint: CPU idle
8,300.6 (86.8%) 14:34:29 INFO - TinderboxPrint: CPU user
1,206.5 (12.6%) 14:34:29 INFO - TinderboxPrint: Swap in / out
0 / 0 14:34:29 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 104267776; Read time: 0; Write time: 75132 14:34:29 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288083968; Read time: 0; Write time: 227680 14:34:29 INFO - Running post-run listener: _upload_blobber_files 14:34:29 INFO - Blob upload gear active. 14:34:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:34:29 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 14:34:29 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:34:29 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:34:30 INFO - (blobuploader) - INFO - Open directory for files ... 14:34:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:34:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:34:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:34:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:34:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:34:34 INFO - (blobuploader) - INFO - Done attempting. 14:34:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:34:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:34:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:34:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:34:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:34:35 INFO - (blobuploader) - INFO - Done attempting. 14:34:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:34:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:34:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:34:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:34:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:34:36 INFO - (blobuploader) - INFO - Done attempting. 14:34:36 INFO - (blobuploader) - INFO - Iteration through files over. 14:34:36 INFO - Return code: 0 14:34:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:34:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:34:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/256d25bc172bb17e19241d3ab414997a454e28d0e10d4c683fec72ee3420dcbfff2c23da68f3840cb747d81c9e59c24cccfe6794f4c76a453bc66932440a75e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b051513f83c8f08d541f6a7ee42459d637704c952a09831de3a169b1181683e102614f9b4eea55a5e3176e66de8e7f56d5f9a953df5424af4fd22043d1fa906e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ae563c12d65fa583d16d5dc17853f228fff973cb5459d4d3976d00398d203d4fe0e401ddf3289d9a86f894c060e09334c61175b79321293111c4d1574f97a23e"} 14:34:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:34:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:34:36 INFO - Contents: 14:34:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/256d25bc172bb17e19241d3ab414997a454e28d0e10d4c683fec72ee3420dcbfff2c23da68f3840cb747d81c9e59c24cccfe6794f4c76a453bc66932440a75e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b051513f83c8f08d541f6a7ee42459d637704c952a09831de3a169b1181683e102614f9b4eea55a5e3176e66de8e7f56d5f9a953df5424af4fd22043d1fa906e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ae563c12d65fa583d16d5dc17853f228fff973cb5459d4d3976d00398d203d4fe0e401ddf3289d9a86f894c060e09334c61175b79321293111c4d1574f97a23e"} 14:34:36 INFO - Running post-run listener: copy_logs_to_upload_dir 14:34:36 INFO - Copying logs to upload dir... 14:34:36 INFO - mkdir: /builds/slave/test/build/upload/logs 14:34:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.157359 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-12-08 14:34:36.002394) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-08 14:34:36.005408) ========= 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=3836458cccd887f2d2de3cf1000001de-1481235231.536358-1396771756 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-Inbound/sha512/256d25bc172bb17e19241d3ab414997a454e28d0e10d4c683fec72ee3420dcbfff2c23da68f3840cb747d81c9e59c24cccfe6794f4c76a453bc66932440a75e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b051513f83c8f08d541f6a7ee42459d637704c952a09831de3a169b1181683e102614f9b4eea55a5e3176e66de8e7f56d5f9a953df5424af4fd22043d1fa906e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ae563c12d65fa583d16d5dc17853f228fff973cb5459d4d3976d00398d203d4fe0e401ddf3289d9a86f894c060e09334c61175b79321293111c4d1574f97a23e"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481229006/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011901 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481229006/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/256d25bc172bb17e19241d3ab414997a454e28d0e10d4c683fec72ee3420dcbfff2c23da68f3840cb747d81c9e59c24cccfe6794f4c76a453bc66932440a75e8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b051513f83c8f08d541f6a7ee42459d637704c952a09831de3a169b1181683e102614f9b4eea55a5e3176e66de8e7f56d5f9a953df5424af4fd22043d1fa906e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ae563c12d65fa583d16d5dc17853f228fff973cb5459d4d3976d00398d203d4fe0e401ddf3289d9a86f894c060e09334c61175b79321293111c4d1574f97a23e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-08 14:34:36.033732) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 14:34:36.034068) ========= 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=3836458cccd887f2d2de3cf1000001de-1481235231.536358-1396771756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.30 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 14:34:36.337547) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-08 14:34:36.337864) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-08 14:34:36.341193) ========= ========= Total master_lag: 0.41 =========