builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1484615921.13 results: success (0) buildid: 20170116171759 builduid: 1a34065fd8f84905bcb58377f29b928b revision: 16e87b06a1d0673cef4845e3de711cbb3d483842 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 17:18:41.128694) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 17:18:41.129104) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 17:18:41.129373) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 17:18:41.161862) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 17:18:41.162172) ========= 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=ed14279e38b05397cf4aa391000001a4-1484611047.118991-845591504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-16 17:18:41-- 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% 32.3M=0s 2017-01-16 17:18:41 (32.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.088785 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 17:18:41.267497) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 17:18:41.267796) ========= 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=ed14279e38b05397cf4aa391000001a4-1484611047.118991-845591504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022366 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 17:18:41.321406) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 17:18:41.322282) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 16e87b06a1d0673cef4845e3de711cbb3d483842 --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 16e87b06a1d0673cef4845e3de711cbb3d483842 --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=ed14279e38b05397cf4aa391000001a4-1484611047.118991-845591504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-16 17:18:41,532 truncating revision to first 12 chars 2017-01-16 17:18:41,532 Setting DEBUG logging. 2017-01-16 17:18:41,532 attempt 1/10 2017-01-16 17:18:41,532 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/16e87b06a1d0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-16 17:18:41,873 unpacking tar archive at: mozilla-inbound-16e87b06a1d0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.626183 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 17:18:41.963369) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 17:18:41.963652) ========= script_repo_revision: 16e87b06a1d0673cef4845e3de711cbb3d483842 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 17:18:41.964019) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 17:18:41.964282) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 17:18:41.977065) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-16 17:18:41.977340) ========= /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=ed14279e38b05397cf4aa391000001a4-1484611047.118991-845591504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:18:42 INFO - MultiFileLogger online at 20170116 17:18:42 in /builds/slave/test 17:18:42 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 17:18:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:18:42 INFO - {'append_to_log': False, 17:18:42 INFO - 'base_work_dir': '/builds/slave/test', 17:18:42 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 17:18:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:18:42 INFO - 'branch': 'Mozilla-Inbound', 17:18:42 INFO - 'buildbot_json_path': 'buildprops.json', 17:18:42 INFO - 'config_files': ('talos/linux_config.py',), 17:18:42 INFO - 'default_actions': ('clobber', 17:18:42 INFO - 'read-buildbot-config', 17:18:42 INFO - 'download-and-extract', 17:18:42 INFO - 'populate-webroot', 17:18:42 INFO - 'create-virtualenv', 17:18:42 INFO - 'install', 17:18:42 INFO - 'run-tests'), 17:18:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:18:42 INFO - 'download_minidump_stackwalk': True, 17:18:42 INFO - 'download_symbols': 'ondemand', 17:18:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:18:42 INFO - 'tooltool.py': '/tools/tooltool.py', 17:18:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:18:42 INFO - '/tools/misc-python/virtualenv.py')}, 17:18:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:18:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:18:42 INFO - 'installer_path': 'installer.exe', 17:18:42 INFO - 'log_level': 'info', 17:18:42 INFO - 'log_name': 'talos', 17:18:42 INFO - 'log_to_console': True, 17:18:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:18:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:18:42 INFO - 'opt_config_files': (), 17:18:42 INFO - 'pip_index': False, 17:18:42 INFO - 'sps_profile': False, 17:18:42 INFO - 'sps_profile_interval': 0, 17:18:42 INFO - 'suite': 'dromaeojs', 17:18:42 INFO - 'system_bits': '32', 17:18:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:18:42 INFO - 'title': 'talos-linux64-ix-035', 17:18:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:18:42 INFO - 'use_talos_json': True, 17:18:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:18:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:18:42 INFO - 'work_dir': 'build'} 17:18:42 INFO - [mozharness: 2017-01-17 01:18:42.280817Z] Running clobber step. 17:18:42 INFO - Running pre-action listener: _resource_record_pre_action 17:18:42 INFO - Running main action method: clobber 17:18:42 INFO - rmtree: /builds/slave/test/build 17:18:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:18:43 INFO - Running post-action listener: _resource_record_post_action 17:18:43 INFO - [mozharness: 2017-01-17 01:18:43.260623Z] Finished clobber step (success) 17:18:43 INFO - [mozharness: 2017-01-17 01:18:43.260722Z] Running read-buildbot-config step. 17:18:43 INFO - Running pre-action listener: _resource_record_pre_action 17:18:43 INFO - Running main action method: read_buildbot_config 17:18:43 INFO - Using buildbot properties: 17:18:43 INFO - { 17:18:43 INFO - "project": "", 17:18:43 INFO - "product": "firefox", 17:18:43 INFO - "script_repo_revision": "production", 17:18:43 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 17:18:43 INFO - "repository": "", 17:18:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 17:18:43 INFO - "buildid": "20170116171759", 17:18:43 INFO - "stage_platform": "linux64-pgo", 17:18:43 INFO - "basedir": "/builds/slave/test", 17:18:43 INFO - "buildnumber": 3244, 17:18:43 INFO - "platform": "ubuntu64_hw", 17:18:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:18:43 INFO - "slavebuilddir": "test", 17:18:43 INFO - "branch": "mozilla-inbound", 17:18:43 INFO - "revision": "16e87b06a1d0673cef4845e3de711cbb3d483842", 17:18:43 INFO - "slavename": "talos-linux64-ix-035", 17:18:43 INFO - "builduid": "1a34065fd8f84905bcb58377f29b928b", 17:18:43 INFO - "repo_path": "integration/mozilla-inbound" 17:18:43 INFO - } 17:18:43 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484609717/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 17:18:43 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484609717/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 17:18:43 INFO - Running post-action listener: _resource_record_post_action 17:18:43 INFO - [mozharness: 2017-01-17 01:18:43.263105Z] Finished read-buildbot-config step (success) 17:18:43 INFO - [mozharness: 2017-01-17 01:18:43.263192Z] Running download-and-extract step. 17:18:43 INFO - Running pre-action listener: _resource_record_pre_action 17:18:43 INFO - Running main action method: download_and_extract 17:18:43 INFO - mkdir: /builds/slave/test/build/tests 17:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:18:43 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484609717/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 17:18:43 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484609717/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 17:18:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484609717/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 17:18:43 INFO - Downloaded 1361 bytes. 17:18:43 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 17:18:43 INFO - Using the following test package requirements: 17:18:43 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 17:18:43 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:18:43 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:18:43 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:18:43 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:18:43 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:18:43 INFO - u'jsshell-linux-x86_64.zip'], 17:18:43 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:18:43 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:18:43 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 17:18:43 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:18:43 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:18:43 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:18:43 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:18:43 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:18:43 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:18:43 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 17:18:43 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:18:43 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:18:43 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/1484609717/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 17:18:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484609717/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:18:43 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484609717/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:18:43 INFO - Expected file size: 21863533 17:18:43 INFO - Obtained file size: 21863533 17:18:47 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 17:18:47 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/1484609717/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 17:18:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484609717/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:18:47 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484609717/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:18:48 INFO - Expected file size: 21863533 17:18:48 INFO - Obtained file size: 21863533 17:18:52 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/1484609717/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 17:18:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484609717/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:18:52 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484609717/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 17:18:52 INFO - Expected file size: 14403463 17:18:52 INFO - Obtained file size: 14403463 17:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:18:52 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484609717/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 17:18:52 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484609717/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 17:18:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484609717/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 17:18:53 INFO - Downloaded 61781322 bytes. 17:18:53 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484609717/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 17:18:53 INFO - mkdir: /builds/slave/test/properties 17:18:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:18:53 INFO - Writing to file /builds/slave/test/properties/build_url 17:18:53 INFO - Contents: 17:18:53 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484609717/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 17:18:53 INFO - Running post-action listener: _resource_record_post_action 17:18:53 INFO - Running post-action listener: set_extra_try_arguments 17:18:53 INFO - [mozharness: 2017-01-17 01:18:53.761903Z] Finished download-and-extract step (success) 17:18:53 INFO - [mozharness: 2017-01-17 01:18:53.762131Z] Running populate-webroot step. 17:18:53 INFO - Running pre-action listener: _resource_record_pre_action 17:18:53 INFO - Running main action method: populate_webroot 17:18:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:18:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:18:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:18:53 INFO - '--tppagecycles', 17:18:53 INFO - '7'], 17:18:53 INFO - 'tests': ['tsvgm']}}, 17:18:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:18:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:18:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:18:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:18:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:18:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:18:53 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:18:53 INFO - 'talos_options': ['--disable-e10s'], 17:18:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:18:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:18:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:18:53 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:18:53 INFO - 'talos_options': ['--disable-e10s'], 17:18:53 INFO - 'tests': ['damp', 'tps']}, 17:18:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:18:53 INFO - 'tests': ['damp', 'tps']}, 17:18:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:18:53 INFO - 'tests': ['dromaeo_dom']}, 17:18:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:18:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:18:53 INFO - 'tests': ['basic_compositor_video']}, 17:18:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:18:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:18:53 INFO - 'tests': ['a11yr', 17:18:53 INFO - 'ts_paint', 17:18:53 INFO - 'tpaint', 17:18:53 INFO - 'sessionrestore', 17:18:53 INFO - 'sessionrestore_no_auto_restore', 17:18:53 INFO - 'tabpaint']}, 17:18:53 INFO - 'other-e10s': {'tests': ['a11yr', 17:18:53 INFO - 'ts_paint', 17:18:53 INFO - 'tpaint', 17:18:53 INFO - 'sessionrestore', 17:18:53 INFO - 'sessionrestore_no_auto_restore', 17:18:53 INFO - 'tabpaint']}, 17:18:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:18:53 INFO - 'ts_paint', 17:18:53 INFO - 'tpaint', 17:18:53 INFO - 'sessionrestore', 17:18:53 INFO - 'sessionrestore_no_auto_restore', 17:18:53 INFO - 'tabpaint']}, 17:18:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:18:53 INFO - 'ts_paint', 17:18:53 INFO - 'tpaint', 17:18:53 INFO - 'sessionrestore', 17:18:53 INFO - 'sessionrestore_no_auto_restore', 17:18:53 INFO - 'tabpaint']}, 17:18:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:18:53 INFO - 'tests': ['a11yr', 17:18:53 INFO - 'ts_paint', 17:18:53 INFO - 'tpaint', 17:18:53 INFO - 'sessionrestore', 17:18:53 INFO - 'sessionrestore_no_auto_restore', 17:18:53 INFO - 'tabpaint']}, 17:18:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:18:53 INFO - 'tests': ['a11yr', 17:18:53 INFO - 'ts_paint', 17:18:53 INFO - 'tpaint', 17:18:53 INFO - 'sessionrestore', 17:18:53 INFO - 'sessionrestore_no_auto_restore', 17:18:53 INFO - 'tabpaint']}, 17:18:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:18:53 INFO - 'tests': ['tsvgx', 17:18:53 INFO - 'tsvgr_opacity', 17:18:53 INFO - 'tart', 17:18:53 INFO - 'tscrollx', 17:18:53 INFO - 'cart', 17:18:53 INFO - 'tsvg_static']}, 17:18:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:18:53 INFO - 'tsvgr_opacity', 17:18:53 INFO - 'tart', 17:18:53 INFO - 'tscrollx', 17:18:53 INFO - 'cart', 17:18:53 INFO - 'tsvg_static']}, 17:18:53 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:18:53 INFO - 'talos_options': ['--disable-e10s'], 17:18:53 INFO - 'tests': ['tp5o']}, 17:18:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:18:53 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:18:53 INFO - 'talos_options': ['--disable-e10s', 17:18:53 INFO - '--xperf_path', 17:18:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:18:53 INFO - 'tests': ['tp5n']}, 17:18:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:18:53 INFO - 'talos_options': ['--xperf_path', 17:18:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:18:53 INFO - 'tests': ['tp5n']}}, 17:18:53 INFO - 'talos.zip': {'path': '', 17:18:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:18:53 INFO - Running post-action listener: _resource_record_post_action 17:18:53 INFO - [mozharness: 2017-01-17 01:18:53.781392Z] Finished populate-webroot step (success) 17:18:53 INFO - [mozharness: 2017-01-17 01:18:53.781480Z] Running create-virtualenv step. 17:18:53 INFO - Running pre-action listener: _resource_record_pre_action 17:18:53 INFO - Running main action method: create_virtualenv 17:18:53 INFO - Creating virtualenv /builds/slave/test/build/venv 17:18:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:18:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:18:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:18:53 INFO - Using real prefix '/usr' 17:18:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:18:54 INFO - Installing distribute.............................................................................................................................................................................................done. 17:18:56 INFO - Installing pip.................done. 17:18:56 INFO - Return code: 0 17:18:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:18:56 INFO - Reading from file tmpfile_stdout 17:18:56 INFO - Output received: 17:18:56 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) 17:18:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:56 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 0xf121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130d850>, '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 0x12826d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1282b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1484611047.118991-845591504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:18:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:18:56 INFO - Using env: {'DISPLAY': ':0', 17:18:56 INFO - 'HOME': '/home/cltbld', 17:18:56 INFO - 'LANG': 'en_US.UTF-8', 17:18:56 INFO - 'LANGUAGE': 'en_US:en', 17:18:56 INFO - 'LOGNAME': 'cltbld', 17:18:56 INFO - 'MAIL': '/var/mail/cltbld', 17:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:56 INFO - 'MOZ_NO_REMOTE': '1', 17:18:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:56 INFO - 'NO_EM_RESTART': '1', 17:18:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:56 INFO - 'PWD': '/builds/slave/test', 17:18:56 INFO - 'SHELL': '/bin/bash', 17:18:56 INFO - 'SHLVL': '1', 17:18:56 INFO - 'TERM': 'linux', 17:18:56 INFO - 'TMOUT': '86400', 17:18:56 INFO - 'USER': 'cltbld', 17:18:56 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1484611047.118991-845591504', 17:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:56 INFO - '_': '/tools/buildbot/bin/python'} 17:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:18:56 INFO - Cleaning up... 17:18:56 INFO - Return code: 0 17:18:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:56 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 0xf121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130d850>, '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 0x12826d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1282b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1484611047.118991-845591504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:18:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:18:56 INFO - Using env: {'DISPLAY': ':0', 17:18:56 INFO - 'HOME': '/home/cltbld', 17:18:56 INFO - 'LANG': 'en_US.UTF-8', 17:18:56 INFO - 'LANGUAGE': 'en_US:en', 17:18:56 INFO - 'LOGNAME': 'cltbld', 17:18:56 INFO - 'MAIL': '/var/mail/cltbld', 17:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:56 INFO - 'MOZ_NO_REMOTE': '1', 17:18:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:56 INFO - 'NO_EM_RESTART': '1', 17:18:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:56 INFO - 'PWD': '/builds/slave/test', 17:18:56 INFO - 'SHELL': '/bin/bash', 17:18:56 INFO - 'SHLVL': '1', 17:18:56 INFO - 'TERM': 'linux', 17:18:56 INFO - 'TMOUT': '86400', 17:18:56 INFO - 'USER': 'cltbld', 17:18:56 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1484611047.118991-845591504', 17:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:56 INFO - '_': '/tools/buildbot/bin/python'} 17:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:57 INFO - Downloading/unpacking psutil>=3.1.1 17:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:18:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:18:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:18:59 INFO - Installing collected packages: psutil 17:18:59 INFO - Running setup.py install for psutil 17:18:59 INFO - building 'psutil._psutil_linux' extension 17:18:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:18:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:18:59 INFO - building 'psutil._psutil_posix' extension 17:18:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:18:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:18:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:18:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:18:59 INFO - Successfully installed psutil 17:18:59 INFO - Cleaning up... 17:18:59 INFO - Return code: 0 17:18:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130d850>, '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 0x12826d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1282b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1484611047.118991-845591504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:18:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:18:59 INFO - Using env: {'DISPLAY': ':0', 17:18:59 INFO - 'HOME': '/home/cltbld', 17:18:59 INFO - 'LANG': 'en_US.UTF-8', 17:18:59 INFO - 'LANGUAGE': 'en_US:en', 17:18:59 INFO - 'LOGNAME': 'cltbld', 17:18:59 INFO - 'MAIL': '/var/mail/cltbld', 17:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:59 INFO - 'MOZ_NO_REMOTE': '1', 17:18:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:59 INFO - 'NO_EM_RESTART': '1', 17:18:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:59 INFO - 'PWD': '/builds/slave/test', 17:18:59 INFO - 'SHELL': '/bin/bash', 17:18:59 INFO - 'SHLVL': '1', 17:18:59 INFO - 'TERM': 'linux', 17:18:59 INFO - 'TMOUT': '86400', 17:18:59 INFO - 'USER': 'cltbld', 17:18:59 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1484611047.118991-845591504', 17:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:59 INFO - '_': '/tools/buildbot/bin/python'} 17:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:19:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:19:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:19:01 INFO - Installing collected packages: mozsystemmonitor 17:19:01 INFO - Running setup.py install for mozsystemmonitor 17:19:02 INFO - Successfully installed mozsystemmonitor 17:19:02 INFO - Cleaning up... 17:19:02 INFO - Return code: 0 17:19:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130d850>, '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 0x12826d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1282b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1484611047.118991-845591504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:19:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:19:02 INFO - Using env: {'DISPLAY': ':0', 17:19:02 INFO - 'HOME': '/home/cltbld', 17:19:02 INFO - 'LANG': 'en_US.UTF-8', 17:19:02 INFO - 'LANGUAGE': 'en_US:en', 17:19:02 INFO - 'LOGNAME': 'cltbld', 17:19:02 INFO - 'MAIL': '/var/mail/cltbld', 17:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:02 INFO - 'MOZ_NO_REMOTE': '1', 17:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:02 INFO - 'NO_EM_RESTART': '1', 17:19:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:02 INFO - 'PWD': '/builds/slave/test', 17:19:02 INFO - 'SHELL': '/bin/bash', 17:19:02 INFO - 'SHLVL': '1', 17:19:02 INFO - 'TERM': 'linux', 17:19:02 INFO - 'TMOUT': '86400', 17:19:02 INFO - 'USER': 'cltbld', 17:19:02 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1484611047.118991-845591504', 17:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:02 INFO - '_': '/tools/buildbot/bin/python'} 17:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:02 INFO - Downloading/unpacking jsonschema==2.5.1 17:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:19:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:04 INFO - Downloading functools32-3.2.3-2.tar.gz 17:19:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:19:04 INFO - warning: no files found matching '*.txt' 17:19:04 INFO - no previously-included directories found matching 'build' 17:19:04 INFO - no previously-included directories found matching 'dist' 17:19:04 INFO - no previously-included directories found matching '.git*' 17:19:04 INFO - Installing collected packages: jsonschema, functools32 17:19:04 INFO - Running setup.py install for functools32 17:19:04 INFO - warning: no files found matching '*.txt' 17:19:04 INFO - no previously-included directories found matching 'build' 17:19:04 INFO - no previously-included directories found matching 'dist' 17:19:04 INFO - no previously-included directories found matching '.git*' 17:19:04 INFO - Successfully installed jsonschema functools32 17:19:04 INFO - Cleaning up... 17:19:04 INFO - Return code: 0 17:19:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:04 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 0xf121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130d850>, '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 0x12826d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1282b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1484611047.118991-845591504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:19:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:19:04 INFO - Using env: {'DISPLAY': ':0', 17:19:04 INFO - 'HOME': '/home/cltbld', 17:19:04 INFO - 'LANG': 'en_US.UTF-8', 17:19:04 INFO - 'LANGUAGE': 'en_US:en', 17:19:04 INFO - 'LOGNAME': 'cltbld', 17:19:04 INFO - 'MAIL': '/var/mail/cltbld', 17:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:04 INFO - 'MOZ_NO_REMOTE': '1', 17:19:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:04 INFO - 'NO_EM_RESTART': '1', 17:19:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:04 INFO - 'PWD': '/builds/slave/test', 17:19:04 INFO - 'SHELL': '/bin/bash', 17:19:04 INFO - 'SHLVL': '1', 17:19:04 INFO - 'TERM': 'linux', 17:19:04 INFO - 'TMOUT': '86400', 17:19:04 INFO - 'USER': 'cltbld', 17:19:04 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1484611047.118991-845591504', 17:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:04 INFO - '_': '/tools/buildbot/bin/python'} 17:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:19:05 INFO - Cleaning up... 17:19:05 INFO - Return code: 0 17:19:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130d850>, '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 0x12826d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1282b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1484611047.118991-845591504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:19:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:19:05 INFO - Using env: {'DISPLAY': ':0', 17:19:05 INFO - 'HOME': '/home/cltbld', 17:19:05 INFO - 'LANG': 'en_US.UTF-8', 17:19:05 INFO - 'LANGUAGE': 'en_US:en', 17:19:05 INFO - 'LOGNAME': 'cltbld', 17:19:05 INFO - 'MAIL': '/var/mail/cltbld', 17:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:05 INFO - 'MOZ_NO_REMOTE': '1', 17:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:05 INFO - 'NO_EM_RESTART': '1', 17:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:05 INFO - 'PWD': '/builds/slave/test', 17:19:05 INFO - 'SHELL': '/bin/bash', 17:19:05 INFO - 'SHLVL': '1', 17:19:05 INFO - 'TERM': 'linux', 17:19:05 INFO - 'TMOUT': '86400', 17:19:05 INFO - 'USER': 'cltbld', 17:19:05 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1484611047.118991-845591504', 17:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:05 INFO - '_': '/tools/buildbot/bin/python'} 17:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:05 INFO - Downloading/unpacking blobuploader==1.2.4 17:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:07 INFO - Downloading blobuploader-1.2.4.tar.gz 17:19:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:19:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:19:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:08 INFO - Downloading docopt-0.6.1.tar.gz 17:19:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:19:08 INFO - Installing collected packages: blobuploader, requests, docopt 17:19:08 INFO - Running setup.py install for blobuploader 17:19:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:19:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:19:08 INFO - Running setup.py install for requests 17:19:08 INFO - Running setup.py install for docopt 17:19:08 INFO - Successfully installed blobuploader requests docopt 17:19:08 INFO - Cleaning up... 17:19:08 INFO - Return code: 0 17:19:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:19:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:08 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 0xf121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130d850>, '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 0x12826d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1282b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1484611047.118991-845591504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:19:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:19:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:19:08 INFO - Using env: {'DISPLAY': ':0', 17:19:08 INFO - 'HOME': '/home/cltbld', 17:19:08 INFO - 'LANG': 'en_US.UTF-8', 17:19:08 INFO - 'LANGUAGE': 'en_US:en', 17:19:08 INFO - 'LOGNAME': 'cltbld', 17:19:08 INFO - 'MAIL': '/var/mail/cltbld', 17:19:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:08 INFO - 'MOZ_NO_REMOTE': '1', 17:19:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:08 INFO - 'NO_EM_RESTART': '1', 17:19:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:08 INFO - 'PWD': '/builds/slave/test', 17:19:08 INFO - 'SHELL': '/bin/bash', 17:19:08 INFO - 'SHLVL': '1', 17:19:08 INFO - 'TERM': 'linux', 17:19:08 INFO - 'TMOUT': '86400', 17:19:08 INFO - 'USER': 'cltbld', 17:19:08 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1484611047.118991-845591504', 17:19:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:08 INFO - '_': '/tools/buildbot/bin/python'} 17:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:19:09 INFO - Running setup.py (path:/tmp/pip-iDCUO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:19:09 INFO - Running setup.py (path:/tmp/pip-cr4jsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:19:09 INFO - Running setup.py (path:/tmp/pip-9wqyMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:19:09 INFO - Running setup.py (path:/tmp/pip-jcRCCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:19:09 INFO - Running setup.py (path:/tmp/pip-36TgS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:19:09 INFO - Running setup.py (path:/tmp/pip-LAXwQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:19:09 INFO - Running setup.py (path:/tmp/pip-uCw0KW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:19:09 INFO - Running setup.py (path:/tmp/pip-Gu25vU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:19:09 INFO - Running setup.py (path:/tmp/pip-1RERKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:19:09 INFO - Running setup.py (path:/tmp/pip-Pc6krD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:19:09 INFO - Running setup.py (path:/tmp/pip-pjdQZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:19:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:19:09 INFO - Running setup.py (path:/tmp/pip-aXzKWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:19:10 INFO - Running setup.py (path:/tmp/pip-8AJdLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:19:10 INFO - Running setup.py (path:/tmp/pip-soGcHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:19:10 INFO - Running setup.py (path:/tmp/pip-Uqiziq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:19:10 INFO - Running setup.py (path:/tmp/pip-rbQ3fc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:19:10 INFO - Running setup.py (path:/tmp/pip-2UYTXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:19:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:19:10 INFO - Running setup.py install for manifestparser 17:19:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:19:10 INFO - Running setup.py install for mozcrash 17:19:10 INFO - Running setup.py install for mozdebug 17:19:10 INFO - Running setup.py install for mozdevice 17:19:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:19:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:19:10 INFO - Running setup.py install for mozfile 17:19:10 INFO - Running setup.py install for mozhttpd 17:19:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:19:11 INFO - Running setup.py install for mozinfo 17:19:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:19:11 INFO - Running setup.py install for mozInstall 17:19:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:19:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:19:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:19:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:19:11 INFO - Running setup.py install for mozleak 17:19:11 INFO - Running setup.py install for mozlog 17:19:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:19:11 INFO - Running setup.py install for moznetwork 17:19:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:19:11 INFO - Running setup.py install for mozprocess 17:19:11 INFO - Running setup.py install for mozprofile 17:19:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:19:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:19:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:19:11 INFO - Running setup.py install for mozrunner 17:19:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:19:11 INFO - Running setup.py install for mozscreenshot 17:19:11 INFO - Running setup.py install for moztest 17:19:12 INFO - Running setup.py install for mozversion 17:19:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:19:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:19:12 INFO - Cleaning up... 17:19:12 INFO - Return code: 0 17:19:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:12 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 0xf121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130d850>, '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 0x12826d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1282b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1484611047.118991-845591504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:19:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:19:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:19:12 INFO - Using env: {'DISPLAY': ':0', 17:19:12 INFO - 'HOME': '/home/cltbld', 17:19:12 INFO - 'LANG': 'en_US.UTF-8', 17:19:12 INFO - 'LANGUAGE': 'en_US:en', 17:19:12 INFO - 'LOGNAME': 'cltbld', 17:19:12 INFO - 'MAIL': '/var/mail/cltbld', 17:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:12 INFO - 'MOZ_NO_REMOTE': '1', 17:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:12 INFO - 'NO_EM_RESTART': '1', 17:19:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:12 INFO - 'PWD': '/builds/slave/test', 17:19:12 INFO - 'SHELL': '/bin/bash', 17:19:12 INFO - 'SHLVL': '1', 17:19:12 INFO - 'TERM': 'linux', 17:19:12 INFO - 'TMOUT': '86400', 17:19:12 INFO - 'USER': 'cltbld', 17:19:12 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1484611047.118991-845591504', 17:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:12 INFO - '_': '/tools/buildbot/bin/python'} 17:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:19:12 INFO - Running setup.py (path:/tmp/pip-PUq779-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:19:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:19:12 INFO - Running setup.py (path:/tmp/pip-rhNPb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:19:12 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)) 17:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:19:12 INFO - Running setup.py (path:/tmp/pip-rCCVUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:19:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:19:12 INFO - Running setup.py (path:/tmp/pip-X07IJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:19:12 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)) 17:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:19:12 INFO - Running setup.py (path:/tmp/pip-bWWLDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:19:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:19:12 INFO - Running setup.py (path:/tmp/pip-e_Q5uS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:19:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:19:12 INFO - Running setup.py (path:/tmp/pip-3mlpc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:19:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:19:12 INFO - Running setup.py (path:/tmp/pip-A9FQo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:19:13 INFO - Running setup.py (path:/tmp/pip-2Ox72o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:19:13 INFO - Running setup.py (path:/tmp/pip-e6fQz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:19:13 INFO - Running setup.py (path:/tmp/pip-PetYD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:19:13 INFO - Running setup.py (path:/tmp/pip-IKrGXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:19:13 INFO - Running setup.py (path:/tmp/pip-IMWfc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:19:13 INFO - Running setup.py (path:/tmp/pip-VQIk_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:19:13 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)) 17:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:19:13 INFO - Running setup.py (path:/tmp/pip-tBRc59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:19:13 INFO - Running setup.py (path:/tmp/pip-t1Axzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:19:13 INFO - Running setup.py (path:/tmp/pip-hzjIBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:19:13 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)) 17:19:13 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)) 17:19:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:19:13 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)) 17:19:13 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)) 17:19:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:19:15 INFO - Downloading blessings-1.6.tar.gz 17:19:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:19:15 INFO - Installing collected packages: blessings 17:19:15 INFO - Running setup.py install for blessings 17:19:15 INFO - Successfully installed blessings 17:19:15 INFO - Cleaning up... 17:19:15 INFO - Return code: 0 17:19:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:19:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:19:16 INFO - Reading from file tmpfile_stdout 17:19:16 INFO - Current package versions: 17:19:16 INFO - argparse == 1.2.1 17:19:16 INFO - blessings == 1.6 17:19:16 INFO - blobuploader == 1.2.4 17:19:16 INFO - docopt == 0.6.1 17:19:16 INFO - functools32 == 3.2.3-2 17:19:16 INFO - jsonschema == 2.5.1 17:19:16 INFO - manifestparser == 1.1 17:19:16 INFO - mozInstall == 1.12 17:19:16 INFO - mozcrash == 1.0 17:19:16 INFO - mozdebug == 0.1 17:19:16 INFO - mozdevice == 0.49 17:19:16 INFO - mozfile == 1.2 17:19:16 INFO - mozhttpd == 0.7 17:19:16 INFO - mozinfo == 0.9 17:19:16 INFO - mozleak == 0.1 17:19:16 INFO - mozlog == 3.4 17:19:16 INFO - moznetwork == 0.27 17:19:16 INFO - mozprocess == 0.24 17:19:16 INFO - mozprofile == 0.28 17:19:16 INFO - mozrunner == 6.13 17:19:16 INFO - mozscreenshot == 0.1 17:19:16 INFO - mozsystemmonitor == 0.3 17:19:16 INFO - moztest == 0.8 17:19:16 INFO - mozversion == 1.4 17:19:16 INFO - psutil == 3.1.1 17:19:16 INFO - requests == 1.2.3 17:19:16 INFO - wsgiref == 0.1.2 17:19:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:19: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')]} 17:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19: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')]} 17:19:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19:16 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 0xf121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130d850>, '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 0x12826d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1282b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1484611047.118991-845591504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:19:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:19:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:19:16 INFO - Using env: {'DISPLAY': ':0', 17:19:16 INFO - 'HOME': '/home/cltbld', 17:19:16 INFO - 'LANG': 'en_US.UTF-8', 17:19:16 INFO - 'LANGUAGE': 'en_US:en', 17:19:16 INFO - 'LOGNAME': 'cltbld', 17:19:16 INFO - 'MAIL': '/var/mail/cltbld', 17:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:16 INFO - 'MOZ_NO_REMOTE': '1', 17:19:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:16 INFO - 'NO_EM_RESTART': '1', 17:19:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:16 INFO - 'PWD': '/builds/slave/test', 17:19:16 INFO - 'SHELL': '/bin/bash', 17:19:16 INFO - 'SHLVL': '1', 17:19:16 INFO - 'TERM': 'linux', 17:19:16 INFO - 'TMOUT': '86400', 17:19:16 INFO - 'USER': 'cltbld', 17:19:16 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1484611047.118991-845591504', 17:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:16 INFO - '_': '/tools/buildbot/bin/python'} 17:19:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:19:16 INFO - Cleaning up... 17:19:16 INFO - Return code: 0 17:19:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:19: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')]} 17:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:19:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19: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')]} 17:19:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:19:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:19: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf121f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x130d850>, '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 0x12826d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1282b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1484611047.118991-845591504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:19: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'] in /builds/slave/test/build 17:19: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 17:19:16 INFO - Using env: {'DISPLAY': ':0', 17:19:16 INFO - 'HOME': '/home/cltbld', 17:19:16 INFO - 'LANG': 'en_US.UTF-8', 17:19:16 INFO - 'LANGUAGE': 'en_US:en', 17:19:16 INFO - 'LOGNAME': 'cltbld', 17:19:16 INFO - 'MAIL': '/var/mail/cltbld', 17:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:16 INFO - 'MOZ_NO_REMOTE': '1', 17:19:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:16 INFO - 'NO_EM_RESTART': '1', 17:19:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:16 INFO - 'PWD': '/builds/slave/test', 17:19:16 INFO - 'SHELL': '/bin/bash', 17:19:16 INFO - 'SHLVL': '1', 17:19:16 INFO - 'TERM': 'linux', 17:19:16 INFO - 'TMOUT': '86400', 17:19:16 INFO - 'USER': 'cltbld', 17:19:16 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1484611047.118991-845591504', 17:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:16 INFO - '_': '/tools/buildbot/bin/python'} 17:19:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:19:16 INFO - Cleaning up... 17:19:16 INFO - Return code: 0 17:19:16 INFO - Running post-action listener: _resource_record_post_action 17:19:16 INFO - Running post-action listener: _start_resource_monitoring 17:19:16 INFO - Starting resource monitoring. 17:19:16 INFO - [mozharness: 2017-01-17 01:19:16.697614Z] Finished create-virtualenv step (success) 17:19:16 INFO - [mozharness: 2017-01-17 01:19:16.698131Z] Running install step. 17:19:16 INFO - Running pre-action listener: _resource_record_pre_action 17:19:16 INFO - Running main action method: install 17:19:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:19:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:19:16 INFO - Reading from file tmpfile_stdout 17:19:16 INFO - Detecting whether we're running mozinstall >=1.0... 17:19:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:19:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:19:16 INFO - Reading from file tmpfile_stdout 17:19:16 INFO - Output received: 17:19:16 INFO - Usage: mozinstall [options] installer 17:19:16 INFO - Options: 17:19:16 INFO - -h, --help show this help message and exit 17:19:16 INFO - -d DEST, --destination=DEST 17:19:16 INFO - Directory to install application into. [default: 17:19:16 INFO - "/builds/slave/test"] 17:19:16 INFO - --app=APP Application being installed. [default: firefox] 17:19:16 INFO - mkdir: /builds/slave/test/build/application 17:19:16 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'] 17:19:16 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 17:19:34 INFO - Reading from file tmpfile_stdout 17:19:34 INFO - Output received: 17:19:34 INFO - /builds/slave/test/build/application/firefox/firefox 17:19:34 INFO - Running post-action listener: _resource_record_post_action 17:19:34 INFO - [mozharness: 2017-01-17 01:19:34.434538Z] Finished install step (success) 17:19:34 INFO - [mozharness: 2017-01-17 01:19:34.434811Z] Running run-tests step. 17:19:34 INFO - Running pre-action listener: _resource_record_pre_action 17:19:34 INFO - Running main action method: run_tests 17:19:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:19:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:19:34 INFO - Python 2.7.3 17:19:34 INFO - Return code: 0 17:19:34 INFO - grabbing minidump binary from tooltool 17:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:19:34 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 0x130d850>, '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 0x12826d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1282b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:19:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:19:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:19:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:19:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:19:34 INFO - Return code: 0 17:19:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:19:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:19:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:19:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:19:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:19:34 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/1484609717/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:19:34 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/1484609717/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:19:34 INFO - Using env: {'DISPLAY': ':0', 17:19:34 INFO - 'HOME': '/home/cltbld', 17:19:34 INFO - 'LANG': 'en_US.UTF-8', 17:19:34 INFO - 'LANGUAGE': 'en_US:en', 17:19:34 INFO - 'LOGNAME': 'cltbld', 17:19:34 INFO - 'MAIL': '/var/mail/cltbld', 17:19:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:19:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:34 INFO - 'MOZ_NO_REMOTE': '1', 17:19:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:19:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:34 INFO - 'NO_EM_RESTART': '1', 17:19:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:34 INFO - 'PWD': '/builds/slave/test', 17:19:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:19:34 INFO - 'SHELL': '/bin/bash', 17:19:34 INFO - 'SHLVL': '1', 17:19:34 INFO - 'TERM': 'linux', 17:19:34 INFO - 'TMOUT': '86400', 17:19:34 INFO - 'USER': 'cltbld', 17:19:34 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1484611047.118991-845591504', 17:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:34 INFO - '_': '/tools/buildbot/bin/python'} 17:19:34 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/1484609717/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:19:34 INFO - mozversion application_buildid: 20170116153517 17:19:34 INFO - mozversion application_changeset: 16e87b06a1d0673cef4845e3de711cbb3d483842 17:19:34 INFO - mozversion application_display_name: Nightly 17:19:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:19:34 INFO - mozversion application_name: Firefox 17:19:34 INFO - mozversion application_remotingname: firefox 17:19:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 17:19:34 INFO - mozversion application_vendor: Mozilla 17:19:34 INFO - mozversion application_version: 53.0a1 17:19:34 INFO - mozversion platform_buildid: 20170116153517 17:19:34 INFO - mozversion platform_changeset: 16e87b06a1d0673cef4845e3de711cbb3d483842 17:19:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 17:19:34 INFO - mozversion platform_version: 53.0a1 17:19:34 INFO - using testdate: 1484615974 17:19:34 INFO - actual date: 1484615974 17:19:34 INFO - starting webserver on 'localhost:36717' 17:19:34 INFO - SUITE-START | Running 2 tests 17:19:34 INFO - TEST-START | dromaeo_css 17:19:34 INFO - operating with platform_type : linux_ 17:19:34 INFO - Initialising browser for dromaeo_css test... 17:19:34 INFO - TEST-INFO | started process 31741 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2OxUWw/profile http://localhost:36717/getInfo.html) 17:19:38 INFO - PROCESS | 31741 | __metrics Screen width/height:1600/1200 17:19:38 INFO - PROCESS | 31741 | colorDepth:24 17:19:38 INFO - PROCESS | 31741 | Browser inner width/height: 1024/697 17:19:38 INFO - PROCESS | 31741 | __metrics 17:19:38 INFO - PROCESS | 31741 | 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" 17:19:38 INFO - PROCESS | 31741 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:19:39 INFO - PROCESS | 31741 | console.error: PushService: 17:19:39 INFO - PROCESS | 31741 | stateChangeProcessEnqueue: Error transitioning state 17:19:39 INFO - PROCESS | 31741 | UnknownError 17:19:39 INFO - TEST-INFO | 31741: exit 0 17:19:39 INFO - Browser initialized. 17:19:39 INFO - Running cycle 1/1 for dromaeo_css test... 17:19:39 INFO - TEST-INFO | started process 31822 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2OxUWw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:19:51 INFO - PROCESS | 31822 | RSS: Main: 147349504 17:19:51 INFO - PROCESS | 31822 | 17:22:53 INFO - PROCESS | 31822 | Cycle 1(1): loaded http://localhost:36717/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36717/tests/dromaeo/cssquery-ext.html) 17:22:54 INFO - PROCESS | 31822 | RSS: Main: 281518080 17:22:54 INFO - PROCESS | 31822 | 17:24:41 INFO - PROCESS | 31822 | ************************* 17:24:41 INFO - PROCESS | 31822 | A coding exception was thrown and uncaught in a Task. 17:24:41 INFO - PROCESS | 31822 | 17:24:41 ERROR - PROCESS | 31822 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:24:41 INFO - PROCESS | 31822 | Full stack: 17:24:41 INFO - PROCESS | 31822 | ************************* 17:25:57 INFO - PROCESS | 31822 | Cycle 1(1): loaded http://localhost:36717/tests/dromaeo/cssquery-ext.html (next: http://localhost:36717/tests/dromaeo/cssquery-jquery.html) 17:25:57 INFO - PROCESS | 31822 | RSS: Main: 243191808 17:25:57 INFO - PROCESS | 31822 | 17:28:59 INFO - PROCESS | 31822 | Cycle 1(1): loaded http://localhost:36717/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36717/tests/dromaeo/cssquery-mootools.html) 17:29:00 INFO - PROCESS | 31822 | RSS: Main: 182370304 17:29:00 INFO - PROCESS | 31822 | 17:32:02 INFO - PROCESS | 31822 | Cycle 1(1): loaded http://localhost:36717/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36717/tests/dromaeo/cssquery-prototype.html) 17:32:02 INFO - PROCESS | 31822 | RSS: Main: 223318016 17:32:02 INFO - PROCESS | 31822 | 17:35:05 INFO - PROCESS | 31822 | Cycle 1(1): loaded http://localhost:36717/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36717/tests/dromaeo/cssquery-yui.html) 17:35:06 INFO - PROCESS | 31822 | RSS: Main: 183984128 17:35:06 INFO - PROCESS | 31822 | 17:38:09 INFO - PROCESS | 31822 | Cycle 1(1): loaded http://localhost:36717/tests/dromaeo/cssquery-yui.html (next: http://localhost:36717/tests/dromaeo/cssquery-dojo.html) 17:38:09 INFO - PROCESS | 31822 | RSS: Main: 268177408 17:38:09 INFO - PROCESS | 31822 | 17:38:09 INFO - PROCESS | 31822 | __start_tp_report 17:38:09 INFO - PROCESS | 31822 | _x_x_mozilla_page_load 17:38:09 INFO - PROCESS | 31822 | _x_x_mozilla_page_load_details 17:38:09 INFO - PROCESS | 31822 | |i|pagename|runs| 17:38:09 INFO - PROCESS | 31822 | |0;dojo.html;3201.695838895305;3217.5978002749657;3240.773145879788;3251.2034551534875;3253.365593709225;5256.316678831756;5284.048871203182;5399.541039011684;5498.835034948953;5499.422560631131;5458.590605704578;5497.587680923917;5547.889042219153;5572.5263352615075;5588.6646801191955;4890.877728056791;4918.581920536759;4951.207806750921;4962.851114466554;4985.750712464381;5001.624878134155;5008.173651347523;5025.045241404122;5029.572486338666;5032.622553308498;4750.263709125056;4797.592204662608;4813.302071199656;4909.091818013679;4950.504949505039;4845.055214233226;4902.705837649717;4932.654714170009;4944.085344211297;4944.629152813553;4867.415910090776;4870.829520966749;4872.196087645534;4891.8777030574165;4912.066707325596;5434.402215756264;5440.075187218183;5441.564674826044;5443.673379597237;5464.098423760075;5686.857828554319;5730.512906402961;5776.046952252873;5828.883422331572;5861.589688721791;5906.881862362771;5917.704114794286;5975.402459754033;5980.521558275327;5982;5508.7521061552325;5509.47659972306;5510.338759348863;5511.724413779335;5514.255575497336;5831.358550559435;5863.2670916135485;5956.583039187215;6008.158857759917;6022.759089636365;5675.3757086720425;5688.488036076773;5712.171735098471;5776.451237132465;5830.38780928005;5706.885862282731;5749.13762935563;5873.706314684248;5883.264591926009;5883.646981181143;5794.420557944172;5809.883802324014;5814.3313518945015;5847.502962248172;5862.589618726648;5747.626404283708;5819.272590926134;5910.645361278337;5913.940860591339;5920.2007728956905;4530;4546.636269098464;4546.772661366918;4581.198290299184;4623.930641040387;4057.3102572562143;4081.20416518776;4082.6733861291027;4113.526944401432;4120.484939382577;5370.570354371719;5572.3034620672415;5573.5819813514145;5577.525910297589;5581.162825576115;5776.335721392094;5903.1145328200255;5904.143899134688;5905.40945905406;5908.025175845937;5436.945630543723;5487.862803429946;5494.917576236359;5497.147942068906;5498.230247765316;4961.5534601886;4966.90066198674;4970.105381031377;4979.551840334388;4981.800727970841;6102.389761023951;6123.877522449615;6144.617461071223;6175.722092505848;6192.102145188832;5976.163337132718;5977.22296101504;5978.252718410199;5979.402059793986;6010.729517171825;5955.374685657944;6013.759449622141;6192.659403732838;6192.97815860378;6193.38066193377;5796.62321949072;5829.09649004405;5850.795222167204;5904.557158213065;5965.34381218057;5969.164316995537;5971.940280597139;5975.462208401264;5976.462118409364;5976.521878249817;5608.523275521627;5848.590598658053;5853.9121913172185;5856.092305692625;5861.589688721749;5700.372958974426;5701.857453563694;5719.799807006735;5753.165790960371;5823.883522329615;5703.20155178267;5753.884922301614;5754.5684073695475;5757.05008673581;5758.424157584208;5669.376368599368;5801.390853960443;5806.883862322646;5807.535397168132;5815.621984570989;5540.889182216414;5598.35618903815;5613.354464236665;5650.491455769001;5754.741036653444 17:38:09 INFO - PROCESS | 31822 | |1;ext.html;568.5082403720781;579.4263678957831;594.6580716088249;603.0893351039931;604.8125081224817;34861.47707784382;44761;46562.999999999956;46674.76662616691;51032.234516482284;48750.51249487504;49295;49309.753451232784;49353.259701104515;49356;9010.053944335832;9200.309976751736;9204.861927071099;9209.907900921005;9216.354855160142;8624.35317351198;8828.881068543535;10570.260081794277;10821.188410869177;10825.729356766065;11042.779144417107;11109.500072496758;11112.11103111749;11115.555377784878;11130.38782866942;10989.06592939601;11054.060404865597;11068.889311106866;11080.612178573792;11085.667429977073;10811.567537298577;10881.83677244842;10883;10893.509792059376;10896.291741036886;44284.335734964;44888.551114488764;44923;44962.32556511655;44966.55033449656;4138.586141385867;4139.317012692902;4147.979260103711;4186.497620285555;4224.239636865363;33089.172770680685;33744.6625533744;34152.14619634529;34169.82915085433;34299.142521436916;4280.101178752466;4347.8043488042795;4395.208862404766;4499.100179963988;4590.563896429834;347647;350103;351585.2420737906;351708;353752;65503.67248163729;65677.67161164164;65911.34088659052;65952;65962.67018664876;69300.72342404076;69362.65318673475;69607;69830.65084674646;69918.3008169922;15747.133907634961;15985.040897546185;15995.200239987955;16005.959612625142;16059.19704014818;11926.1651684383;12243.387830608433;12856.807147892789;13015.088943774033;13023.47906083765;18747.343842965704;19064.80935190658;19171.904140479208;19727.112279947436;19927.402177934684;6486.416222539994;6547.705353259114;6580.177477815273;6687.4984376171005;6742.359475849787;918.6325469811995;945.2438049560325;945.3524335829978;946.3801210207325;961.0821665309612;31390.686093138775;33128.80375137175;33406;33418.49872251918;33498.66501334956;986.2307400227834;1125.285443743229;1140.0594509529506;1145.0724912820642;1163.057923082306;17259.223334949707;17589.560260993323;17634.206460709298;17635.382761603283;17733.11334433273;472283;472738;473473;473508;474193;64527.35472645213;64835.67582162059;64884;64895.67552162209;64922;1465.9853401465848;1466.9046511976687;1496.3416096917322;1498.6777842763859;1503.323504422992;30621;32125.51811722779;32311.192220194684;32532.51201232031;32845.83577082195;53440;55191.72404137954;55241;55340;55369;372811;373866;374029;374681;375002;37905.43141852819;42211.577884220766;42799.7860010698;42897.571024290606;43229.56770432255;43661;47001;49555.50444495509;49673;55075.724621376634;41569.58430415778;43836.34245486384;44120;44566.77716611396;45213.77393113145;42464.36303455512;43051.35422968595;43142.56857431511;44011.77994110009;44950;41589;41850.37224441575;43267.56732432635;43291.35062974121;43324;35122.47316290309;36828.45016771609;37338.25323493569;37390.8130459346;38037;28011.299717507227;28173.43653126885;28379.57430638501;28647.57028644614;28776.712232877402 17:38:09 INFO - PROCESS | 31822 | |2;jquery.html;392.1059983238218;396.8134976561015;398.92021595680836;400.3714168755055;419.85305143199884;15230.695386092271;19482.512937176576;20231.291904783335;21027.053782579784;21035.26376576818;16257.91871040646;18432.26270949164;20033.699494507593;20193.89903050483;21339.35981920541;5639.407862174464;5917.053271476565;5924.940750592482;5926.199963004982;5953.404659534055;5684.943150568482;5805.36141024487;5829.154772557977;5848.824535263949;5852.385499522553;5818.156367326735;5852.590318677694;5856.063029915214;5857.26784151981;5858.531317494611;5665.121906104539;5777.566682498829;5813.825585232407;5854.648721076728;5855.033919403315;5128.1282182029145;5129.435762066169;5138.46046165151;5143.048536020848;5144.408393034774;23885.522289554112;24399.756002439924;24485;24688;24851.875740621363;2755.9035433759723;2778.597103419993;2796.9160925172278;2815.8310501369983;2845.9573106403423;13966.650833729136;15172.393104275816;15288.235588220656;15465.613359665986;15847.984866013616;1904.3144467991513;1937.5931054478576;1942.5920556683113;1946.1826033066145;1948.9610207795906;94569.52715236449;95081.52459237659;95092.52453737757;96501.5174924128;98281.81786369544;10281.126104281071;10382.169426446017;10514.106300964351;10524.421156836448;10651.467426628638;14321.78517322241;14331.713365732627;14345.354459049368;14357.353919073457;14390.928045359706;6883;7208.459365547605;7768.805779855549;8124.796880077927;8561.82876342482;8434.746957591282;8496.405251632326;8535.445196062235;8773.561321933877;8780.648774048967;6893.620850853251;6932;6939.479539034492;7001.754938577227;7090.468214883905;1785.9285628574971;1786.2129492958736;1808.3489943620286;1864.3008871673123;1893.422506135642;858.4076986879033;874.1957399192758;882.3955590420583;889.4840992224495;905.1175104273412;19670.70493942592;20062.297819576244;21078.683819742717;21237.575248494944;21269.893650531958;884.787650963764;885.1325700813239;898.1557336104172;898.5462341517492;905.9411138275991;11649.88350116488;11747.941260293645;11882.28706277626;11887.70280742971;11967;630771;631885;633001;653539;682149;93021.5348923251;93375.53312233531;93568.53215734015;93759;94449.5277523608;1112.1769890281134;1118.8769235384102;1125.9042981346513;1138.2146319039837;1143.2625956258166;17467.650646987244;17486.213120409357;17972.460826175236;17996.820031799514;18394.1722622485;42659.360109599;43110;43228.78385608052;43243.56756432395;43646.56353436425;54941.175882361;55197.72401137969;55950;56037.43962560322;57328.71335643295;7821.491603045783;8021.959890200512;8126.83746325082;8277.793055173668;8457.746267611981;13915.652108697364;14017.929910350791;14060.226687532284;14110;14159.36282867294;11895.881041189477;11908.34504102248;12033.63899083029;12211.450484728031;12278.75442491163;11177.944110279723;11900.642980710592;12210.26738395699;12379.93810030944;12440.813387799371;12511.874881251435;12603.432845521791;12610.87389126097;12619.36903154857;12637.914744067493;7946.364290856602;8944.37389382737;9023.729288121367;9230.75385322759;9360.017198194364;10347.896521034694;11607.419629018346;11808;11921;12176.33030183313 17:38:09 INFO - PROCESS | 31822 | |3;mootools.html;1462.6708990477136;1464.3776395032116;1479.3047267784145;1480.4892312152308;1481.511101336559;7876.645550950207;8305;8311.251987321133;8315.168483151698;8331.416800823945;7361.337479626833;7564.773056808291;8159.836803263931;8171.795705107375;8380.32957363411;2336.2991102669175;2368.7631236876346;2372;2374.5844477216506;2375.3705268103968;2192.7039849620255;2253.0987604957986;2259.8418110732255;2261.457250259942;2263.5246598214394;2350.8589484630975;2366.4438856868624;2381.1665916929023;2381.535600557892;2385.5825230584664;2317.050009496107;2325.767423257678;2326.755690652474;2342.7540108288727;2349.6240601503678;2260.446190683293;2288.5766133265397;2290.5189910118893;2290.7480177180496;2299.1608063056865;8573.271271941892;8633.007204171538;8636.136386361377;8640.092790257058;8641.179087986631;5223.138182199932;5381.327334083239;5388.218708287315;5396.730163491809;5408.756605952742;3406.403879321109;3464.2725027744204;3669.7798132112157;3684.6868016218655;3704;1358.2325985817981;1363.9386227619782;1375.9931200344033;1401.3133564553295;1529.1360381384482;11528.365939873303;11571.247868888495;11575.36335501547;11597.884021159849;11617.419129043514;4707.670463067621;4731.4795372509;4905.852824415273;4914.778834952435;4928.507149285043;9289.72130836076;9365.203957663538;9372;9390.389624674373;9393.859092113487;5394.811181608625;5395.757190926418;5399.946000540023;5401.2985909439185;5405.405405405402;4126.814293356806;4956.752162391866;5014.924776128361;5079.212722028018;5105.361829771278;3782.924341513154;3851.114243723959;3868.6131386861653;3880.689544836406;3905.921881562353;1167.620523329921;1174.277819141222;1175.9176857619884;1181.8490347567517;1184.7156682396162;933.6172169410645;934.3833070173789;936.5598168860624;945.8628498867625;958.8609651600478;5216.7913283469;5869.148973398833;5886.823395298148;5922.881542369215;6245.96877015612;1004.6232662751469;1017.1100287248657;1027.5735569738474;1053.373242920461;1060.2578195263347;3960.574193290413;4008.5590585035625;4045.7977101144825;4116.300228961084;4173.478315210598;9840.852387214198;10183.7454063649;10185.185185185168;10200.28597998133;10218.795624087625;9982.80034399308;10076.445795481171;10095;10095.545700443497;10099.192064634812;7951.960240198762;7970.362371010306;8082.221911179531;8093.757187284391;8103.149169337253;5522.447755224606;5782.363939966516;5861.1501332305725;5898.587098903035;6023.879522409439;9388.248940084914;9580.425174489554;9589.568469419033;9639.132478077006;9702.805943881223;9873.40759554429;9967.352122112039;9985.201183905416;9992.250581206585;10011.199104071802;6238.532110091852;6404.583702059351;6942.340477654615;7158.248383919822;7282.089738782653;8320.625571849403;8396.622152003296;8480.533570653673;8481.533515656698;8485;7313.158986716596;7340.816479588053;7455.142658594114;7509.962450187714;7556.282153195438;7314.414846812136;7374.557526548424;7378.5941773202985;7382.151052629017;7410.258974102547;6450.870982580228;6559.704813283318;6564.015397690385;6565.606063636197;6570.178727659043;5079.593632509316;5105.795768169231;5144.6913185209005;5189.169732842727;5393.056215162409;5360.65155764874;5381;5412.7564259607625;5476.945230547643;5677.602567820213 17:38:09 INFO - PROCESS | 31822 | |4;prototype.html;356.13281659159946;363.40945962810434;364.8668236093825;366.0701817383845;370.4905754587442;5272.446393128724;5272.551833094187;5276.604254680895;5339.279197308362;5340.172273297635;5005.4494005659435;5071;5167.080599461302;5173.560247378968;5243.348345271237;4109.383592461125;4124.216398884202;4125.9174816503655;4128.958710412895;4137.213929353428;4083.7958102094926;4101.3847922811665;4107.260693075245;4138.317177665696;4148.896277593054;3958.683305335581;4015.8755548446484;4083.9591604084026;4093.9590604093873;4123.3196522573735;4102.487189101363;4104.651104656108;4107.876763697094;4111.259973204822;4118.485189351346;3697.8890633281044;3705.3330400527893;3709.332320182366;3710.8330125144435;3719.79541125238;4953.876153096166;5059.165237735806;5112.693238405707;5177.326947496801;5190.584753219733;4758.762061896891;4768.5946694531;4769.713817170981;4770.761461926924;4783.808647654089;5475.260839786618;5490.6431081979545;5495.780168793243;5506.174073888908;5528.944710552883;3685.1892583631557;3849.6727778138893;3874.496315478998;4115.71190016699;4116.567760385176;5673.971630141823;5693.925280348607;5703.429657034263;5706.258186435778;5707.800226992035;3955.3275943089743;3956.9010774730286;3975.8807235782974;3980.800959951991;3983.2830090583975;3941.881743547698;4000.419939108871;4018.176273863851;4022.7988600569856;4026.295398305285;4579.862604121815;4599.33309670096;4600.194965880957;4604.861854144381;4606.239970404846;5484.8354549363585;5500.532454741392;5507;5511.5039646432015;5512.972435137799;1300.7138429545485;1332.2938842413537;1332.6868185976289;1334.0989090545934;1343.7312537492542;901.3285102598475;901.6348378906554;915.2906497464518;916.4043371808378;918.3892711347013;5098.648858052619;5104.770285337095;5107.361579802525;5142.717150556755;5149.948500515022;5454.563634909197;5484.61607687466;5494.642848214853;5535.806246781343;5541.9168712469345;4923.581495572845;4991.251312303111;5043.5965122790085;5083.898322033612;5100.285959965608;2885;2894.5658151277476;2895.406441679451;2896.493113705093;2901.854907254671;5395.974764794676;5611.466910643482;5623.5097699109765;5640.5487560995025;5653;5596.468335508202;5607.691576963224;5609.5792815539;5615.697563998741;5616.595851037241;5586.636868603609;5607.691576963306;5622.345475440996;5624.521915637135;5631.690257035739;5249.160134378634;5421.349438067457;5435.809746658848;5442.210879422382;5443.938432005721;5385.299911011543;5387.353517577916;5408.675479471244;5414.864628384322;5414.891702166014;5371.946280537145;5550.69471179089;5574.5261652758345;5622.116590942081;5626.971865140648;3724.7578907370935;3775.3393156198103;3780.8865734028022;3781.489498917611;3788.1287303920803;5353.384360798558;5393.7033463159905;5488.615796894179;5500.80747173847;5628.324601047901;5495.505404513613;5522.30971128609;5524;5538.6122971391615;5542.861428464321;5240.213967904845;5520.917186242129;5529.391766905717;5529.474699903502;5532.529734972572;5493.478119578634;5496.7526461310135;5497.835064948058;5504.201890725903;5529.391766905556;5482.5613950883035;5519.199716041071;5523.59148417151;5538.307711536058;5540.750666219949;5114.360704911886;5324.866878328073;5364.839054828361;5366.758495867617;5395.649282796606 17:38:09 INFO - PROCESS | 31822 | |5;yui.html;778.6612823421812;788.4283894176726;812.9268365847076;860.3160487412508;873.2664561768114;15656.21718914054;17330.393436229733;17340.82659173408;17345.826541734594;17348.739768903477;15510.224488775544;15677.529674109766;15680.215989200522;15686.607834804136;15688;642.1074706158444;646.8706258748269;722.0360818307565;737.5722081192895;739.1758189618563;749.1609397474808;757.2541047068632;761.6382218446222;761.77146855943;761.889526018727;803.8673618852882;804.9839003219932;805.480465100013;806.1696452653777;806.8386322735447;677.5494296293009;679.5073571660506;800.0918956983836;800.4236949396454;800.7077416742876;558.062455075473;561.6910699115512;565.3244372974298;579.1370857422453;580.2862479150626;15773;16143.838561614351;16182.919085404616;16275.755863662054;16282.51152465428;14724.116553006854;15004;15142.697146057017;15659.608509787233;15773.211339432983;12759.923448392105;12773.680657983625;12835.422405991752;12836.358182090951;12899.93550032244;3843.6348546888003;4347.630451411634;4369.4319738434115;4426.513083560806;4490.663200259961;82087;82395.52813415547;82803.58598206971;83309.58345208236;83683.2342544587;11407;11508.309501429942;11509.712257193638;11647.359395233343;11685;21753.45616359572;21856.562868742538;21858.672119918214;21964.341069767932;22102.88948555247;8125.228103330174;8249.175082491704;8268.793280168044;8575.099614540508;8586.141385861489;4612.308153776893;4646.395968524071;4706.623470122382;4715.056988602293;4799.232122860326;3699.130704284491;3811.9809400953372;3817.351050321452;3818.9809050955123;3823.636754508317;629.6064959400375;647.8315637934077;647.8866198415259;648.0279580629057;648.060312546809;764.9923500764921;776.9650365733555;787.8778789287669;787.9369650427952;796.9800754981172;10647.733806654896;10712.46437678113;11172.162087843282;11352.886471135349;11357.318560886208;606.548121649374;622.3745136138152;632.6362341653568;642.1363266406676;648.1671052697261;4859.538343857328;5194.506521880416;5197.194434862602;5257.973710131425;5338.679679219182;58026.41973580295;60246.698766505884;71101;74781.25218747852;74892.25107748853;67907;69012.30987690159;69425;70877.2912270881;70900.64549677321;62862.37137628657;63001;63261;63524.68237658782;65552.67223663851;10098.94950525272;10821.891781082088;10893.56425742993;10989.747101843943;11364.54541818318;38182;38568.6143138565;39502.40746388749;41137.58862411457;41181.382279266436;53134.46865531295;53292.73353633207;53518.46481535135;55200.17199741927;56337;13175.538856139989;13462;13465.730685386434;13762.380692869045;13924.512642057885;14374.907090827757;14539.709205816036;15025.699486010437;15084.924575377054;15513.37946482128;10991.340519568852;13598.184108953494;13770.449182032606;14146.929265353607;14558.344874480885;12658.620241392773;12662.936685316514;12811.762660507016;12939.805902911652;13271.898533492104;12415;12548.874511255135;13175.275359854917;13295.335233238493;13384.330783460593;11631.76736465283;11652.721118820145;11769.764604707687;11834.467448964646;11945.581904633296;10321.432321222404;11238.606648767254;11425.2002359834;11621.825672614748;11721.296722196696 17:38:09 INFO - PROCESS | 31822 | __end_tp_report 17:38:09 INFO - PROCESS | 31822 | __start_cc_report 17:38:09 INFO - PROCESS | 31822 | _x_x_mozilla_cycle_collect,1190 17:38:09 INFO - PROCESS | 31822 | __end_cc_report 17:38:09 INFO - PROCESS | 31822 | __startTimestamp1484617089257__endTimestamp 17:38:09 INFO - PROCESS | 31822 | 17:38:09 INFO - PROCESS | 31822 | ------- Summary: start ------- 17:38:09 INFO - PROCESS | 31822 | Number of tests: 6 17:38:09 INFO - PROCESS | 31822 | 17:38:09 INFO - PROCESS | 31822 | [#0] dojo.html Cycles:165 Average:5452.57 Median:5686.86 stddev:622.68 (10.9%) stddev-sans-first:599.03 17:38:09 INFO - PROCESS | 31822 | Values: 3201.7 3217.6 3240.8 3251.2 3253.4 5256.3 5284.0 5399.5 5498.8 5499.4 5458.6 5497.6 5547.9 5572.5 5588.7 4890.9 4918.6 4951.2 4962.9 4985.8 5001.6 5008.2 5025.0 5029.6 5032.6 4750.3 4797.6 4813.3 4909.1 4950.5 4845.1 4902.7 4932.7 4944.1 4944.6 4867.4 4870.8 4872.2 4891.9 4912.1 5434.4 5440.1 5441.6 5443.7 5464.1 5686.9 5730.5 5776.0 5828.9 5861.6 5906.9 5917.7 5975.4 5980.5 5982.0 5508.8 5509.5 5510.3 5511.7 5514.3 5831.4 5863.3 5956.6 6008.2 6022.8 5675.4 5688.5 5712.2 5776.5 5830.4 5706.9 5749.1 5873.7 5883.3 5883.6 5794.4 5809.9 5814.3 5847.5 5862.6 5747.6 5819.3 5910.6 5913.9 5920.2 4530.0 4546.6 4546.8 4581.2 4623.9 4057.3 4081.2 4082.7 4113.5 4120.5 5370.6 5572.3 5573.6 5577.5 5581.2 5776.3 5903.1 5904.1 5905.4 5908.0 5436.9 5487.9 5494.9 5497.1 5498.2 4961.6 4966.9 4970.1 4979.6 4981.8 6102.4 6123.9 6144.6 6175.7 6192.1 5976.2 5977.2 5978.3 5979.4 6010.7 5955.4 6013.8 6192.7 6193.0 6193.4 5796.6 5829.1 5850.8 5904.6 5965.3 5969.2 5971.9 5975.5 5976.5 5976.5 5608.5 5848.6 5853.9 5856.1 5861.6 5700.4 5701.9 5719.8 5753.2 5823.9 5703.2 5753.9 5754.6 5757.1 5758.4 5669.4 5801.4 5806.9 5807.5 5815.6 5540.9 5598.4 5613.4 5650.5 5754.7 17:38:09 INFO - PROCESS | 31822 | 17:38:09 INFO - PROCESS | 31822 | [#1] ext.html Cycles:180 Average:58729.99 Median:23199.04 stddev:106062.84 (457.2%) stddev-sans-first:106270.48 17:38:09 INFO - PROCESS | 31822 | Values: 568.5 579.4 594.7 603.1 604.8 34861.5 44761.0 46563.0 46674.8 51032.2 48750.5 49295.0 49309.8 49353.3 49356.0 9010.1 9200.3 9204.9 9209.9 9216.4 8624.4 8828.9 10570.3 10821.2 10825.7 11042.8 11109.5 11112.1 11115.6 11130.4 10989.1 11054.1 11068.9 11080.6 11085.7 10811.6 10881.8 10883.0 10893.5 10896.3 44284.3 44888.6 44923.0 44962.3 44966.6 4138.6 4139.3 4148.0 4186.5 4224.2 33089.2 33744.7 34152.1 34169.8 34299.1 4280.1 4347.8 4395.2 4499.1 4590.6 347647.0 350103.0 351585.2 351708.0 353752.0 65503.7 65677.7 65911.3 65952.0 65962.7 69300.7 69362.7 69607.0 69830.7 69918.3 15747.1 15985.0 15995.2 16006.0 16059.2 11926.2 12243.4 12856.8 13015.1 13023.5 18747.3 19064.8 19171.9 19727.1 19927.4 6486.4 6547.7 6580.2 6687.5 6742.4 918.6 945.2 945.4 946.4 961.1 31390.7 33128.8 33406.0 33418.5 33498.7 986.2 1125.3 1140.1 1145.1 1163.1 17259.2 17589.6 17634.2 17635.4 17733.1 472283.0 472738.0 473473.0 473508.0 474193.0 64527.4 64835.7 64884.0 64895.7 64922.0 1466.0 1466.9 1496.3 1498.7 1503.3 30621.0 32125.5 32311.2 32532.5 32845.8 53440.0 55191.7 55241.0 55340.0 55369.0 372811.0 373866.0 374029.0 374681.0 375002.0 37905.4 42211.6 42799.8 42897.6 43229.6 43661.0 47001.0 49555.5 49673.0 55075.7 41569.6 43836.3 44120.0 44566.8 45213.8 42464.4 43051.4 43142.6 44011.8 44950.0 41589.0 41850.4 43267.6 43291.4 43324.0 35122.5 36828.5 37338.3 37390.8 38037.0 28011.3 28173.4 28379.6 28647.6 28776.7 17:38:09 INFO - PROCESS | 31822 | 17:38:09 INFO - PROCESS | 31822 | [#2] jquery.html Cycles:180 Average:34146.50 Median:394.46 stddev:106113.65 (26901.0%) stddev-sans-first:106381.06 17:38:09 INFO - PROCESS | 31822 | Values: 392.1 396.8 398.9 400.4 419.9 15230.7 19482.5 20231.3 21027.1 21035.3 16257.9 18432.3 20033.7 20193.9 21339.4 5639.4 5917.1 5924.9 5926.2 5953.4 5684.9 5805.4 5829.2 5848.8 5852.4 5818.2 5852.6 5856.1 5857.3 5858.5 5665.1 5777.6 5813.8 5854.6 5855.0 5128.1 5129.4 5138.5 5143.0 5144.4 23885.5 24399.8 24485.0 24688.0 24851.9 2755.9 2778.6 2796.9 2815.8 2846.0 13966.7 15172.4 15288.2 15465.6 15848.0 1904.3 1937.6 1942.6 1946.2 1949.0 94569.5 95081.5 95092.5 96501.5 98281.8 10281.1 10382.2 10514.1 10524.4 10651.5 14321.8 14331.7 14345.4 14357.4 14390.9 6883.0 7208.5 7768.8 8124.8 8561.8 8434.7 8496.4 8535.4 8773.6 8780.6 6893.6 6932.0 6939.5 7001.8 7090.5 1785.9 1786.2 1808.3 1864.3 1893.4 858.4 874.2 882.4 889.5 905.1 19670.7 20062.3 21078.7 21237.6 21269.9 884.8 885.1 898.2 898.5 905.9 11649.9 11747.9 11882.3 11887.7 11967.0 630771.0 631885.0 633001.0 653539.0 682149.0 93021.5 93375.5 93568.5 93759.0 94449.5 1112.2 1118.9 1125.9 1138.2 1143.3 17467.7 17486.2 17972.5 17996.8 18394.2 42659.4 43110.0 43228.8 43243.6 43646.6 54941.2 55197.7 55950.0 56037.4 57328.7 7821.5 8022.0 8126.8 8277.8 8457.7 13915.7 14017.9 14060.2 14110.0 14159.4 11895.9 11908.3 12033.6 12211.5 12278.8 11177.9 11900.6 12210.3 12379.9 12440.8 12511.9 12603.4 12610.9 12619.4 12637.9 7946.4 8944.4 9023.7 9230.8 9360.0 10347.9 11607.4 11808.0 11921.0 12176.3 17:38:09 INFO - PROCESS | 31822 | 17:38:09 INFO - PROCESS | 31822 | [#3] mootools.html Cycles:180 Average:5610.32 Median:5370.83 stddev:3044.47 (56.7%) stddev-sans-first:3037.05 17:38:09 INFO - PROCESS | 31822 | Values: 1462.7 1464.4 1479.3 1480.5 1481.5 7876.6 8305.0 8311.3 8315.2 8331.4 7361.3 7564.8 8159.8 8171.8 8380.3 2336.3 2368.8 2372.0 2374.6 2375.4 2192.7 2253.1 2259.8 2261.5 2263.5 2350.9 2366.4 2381.2 2381.5 2385.6 2317.1 2325.8 2326.8 2342.8 2349.6 2260.4 2288.6 2290.5 2290.7 2299.2 8573.3 8633.0 8636.1 8640.1 8641.2 5223.1 5381.3 5388.2 5396.7 5408.8 3406.4 3464.3 3669.8 3684.7 3704.0 1358.2 1363.9 1376.0 1401.3 1529.1 11528.4 11571.2 11575.4 11597.9 11617.4 4707.7 4731.5 4905.9 4914.8 4928.5 9289.7 9365.2 9372.0 9390.4 9393.9 5394.8 5395.8 5399.9 5401.3 5405.4 4126.8 4956.8 5014.9 5079.2 5105.4 3782.9 3851.1 3868.6 3880.7 3905.9 1167.6 1174.3 1175.9 1181.8 1184.7 933.6 934.4 936.6 945.9 958.9 5216.8 5869.1 5886.8 5922.9 6246.0 1004.6 1017.1 1027.6 1053.4 1060.3 3960.6 4008.6 4045.8 4116.3 4173.5 9840.9 10183.7 10185.2 10200.3 10218.8 9982.8 10076.4 10095.0 10095.5 10099.2 7952.0 7970.4 8082.2 8093.8 8103.1 5522.4 5782.4 5861.2 5898.6 6023.9 9388.2 9580.4 9589.6 9639.1 9702.8 9873.4 9967.4 9985.2 9992.3 10011.2 6238.5 6404.6 6942.3 7158.2 7282.1 8320.6 8396.6 8480.5 8481.5 8485.0 7313.2 7340.8 7455.1 7510.0 7556.3 7314.4 7374.6 7378.6 7382.2 7410.3 6450.9 6559.7 6564.0 6565.6 6570.2 5079.6 5105.8 5144.7 5189.2 5393.1 5360.7 5381.0 5412.8 5476.9 5677.6 17:38:09 INFO - PROCESS | 31822 | 17:38:09 INFO - PROCESS | 31822 | [#4] prototype.html Cycles:180 Average:4569.41 Median:5241.78 stddev:1335.25 (25.5%) stddev-sans-first:1301.01 17:38:09 INFO - PROCESS | 31822 | Values: 356.1 363.4 364.9 366.1 370.5 5272.4 5272.6 5276.6 5339.3 5340.2 5005.4 5071.0 5167.1 5173.6 5243.3 4109.4 4124.2 4125.9 4129.0 4137.2 4083.8 4101.4 4107.3 4138.3 4148.9 3958.7 4015.9 4084.0 4094.0 4123.3 4102.5 4104.7 4107.9 4111.3 4118.5 3697.9 3705.3 3709.3 3710.8 3719.8 4953.9 5059.2 5112.7 5177.3 5190.6 4758.8 4768.6 4769.7 4770.8 4783.8 5475.3 5490.6 5495.8 5506.2 5528.9 3685.2 3849.7 3874.5 4115.7 4116.6 5674.0 5693.9 5703.4 5706.3 5707.8 3955.3 3956.9 3975.9 3980.8 3983.3 3941.9 4000.4 4018.2 4022.8 4026.3 4579.9 4599.3 4600.2 4604.9 4606.2 5484.8 5500.5 5507.0 5511.5 5513.0 1300.7 1332.3 1332.7 1334.1 1343.7 901.3 901.6 915.3 916.4 918.4 5098.6 5104.8 5107.4 5142.7 5149.9 5454.6 5484.6 5494.6 5535.8 5541.9 4923.6 4991.3 5043.6 5083.9 5100.3 2885.0 2894.6 2895.4 2896.5 2901.9 5396.0 5611.5 5623.5 5640.5 5653.0 5596.5 5607.7 5609.6 5615.7 5616.6 5586.6 5607.7 5622.3 5624.5 5631.7 5249.2 5421.3 5435.8 5442.2 5443.9 5385.3 5387.4 5408.7 5414.9 5414.9 5371.9 5550.7 5574.5 5622.1 5627.0 3724.8 3775.3 3780.9 3781.5 3788.1 5353.4 5393.7 5488.6 5500.8 5628.3 5495.5 5522.3 5524.0 5538.6 5542.9 5240.2 5520.9 5529.4 5529.5 5532.5 5493.5 5496.8 5497.8 5504.2 5529.4 5482.6 5519.2 5523.6 5538.3 5540.8 5114.4 5324.9 5364.8 5366.8 5395.6 17:38:09 INFO - PROCESS | 31822 | 17:38:09 INFO - PROCESS | 31822 | [#5] yui.html Cycles:180 Average:17601.97 Median:22764.51 stddev:21906.09 (96.2%) stddev-sans-first:21931.11 17:38:09 INFO - PROCESS | 31822 | Values: 778.7 788.4 812.9 860.3 873.3 15656.2 17330.4 17340.8 17345.8 17348.7 15510.2 15677.5 15680.2 15686.6 15688.0 642.1 646.9 722.0 737.6 739.2 749.2 757.3 761.6 761.8 761.9 803.9 805.0 805.5 806.2 806.8 677.5 679.5 800.1 800.4 800.7 558.1 561.7 565.3 579.1 580.3 15773.0 16143.8 16182.9 16275.8 16282.5 14724.1 15004.0 15142.7 15659.6 15773.2 12759.9 12773.7 12835.4 12836.4 12899.9 3843.6 4347.6 4369.4 4426.5 4490.7 82087.0 82395.5 82803.6 83309.6 83683.2 11407.0 11508.3 11509.7 11647.4 11685.0 21753.5 21856.6 21858.7 21964.3 22102.9 8125.2 8249.2 8268.8 8575.1 8586.1 4612.3 4646.4 4706.6 4715.1 4799.2 3699.1 3812.0 3817.4 3819.0 3823.6 629.6 647.8 647.9 648.0 648.1 765.0 777.0 787.9 787.9 797.0 10647.7 10712.5 11172.2 11352.9 11357.3 606.5 622.4 632.6 642.1 648.2 4859.5 5194.5 5197.2 5258.0 5338.7 58026.4 60246.7 71101.0 74781.3 74892.3 67907.0 69012.3 69425.0 70877.3 70900.6 62862.4 63001.0 63261.0 63524.7 65552.7 10098.9 10821.9 10893.6 10989.7 11364.5 38182.0 38568.6 39502.4 41137.6 41181.4 53134.5 53292.7 53518.5 55200.2 56337.0 13175.5 13462.0 13465.7 13762.4 13924.5 14374.9 14539.7 15025.7 15084.9 15513.4 10991.3 13598.2 13770.4 14146.9 14558.3 12658.6 12662.9 12811.8 12939.8 13271.9 12415.0 12548.9 13175.3 13295.3 13384.3 11631.8 11652.7 11769.8 11834.5 11945.6 10321.4 11238.6 11425.2 11621.8 11721.3 17:38:09 INFO - PROCESS | 31822 | -------- Summary: end -------- 17:38:09 INFO - PROCESS | 31822 | 17:38:09 INFO - TEST-INFO | 31822: exit 0 17:38:09 INFO - TEST-OK | dromaeo_css | took 1115260ms 17:38:09 INFO - TEST-START | kraken 17:38:09 INFO - operating with platform_type : linux_ 17:38:09 INFO - Initialising browser for kraken test... 17:38:09 INFO - TEST-INFO | started process 32125 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC_2B8L/profile http://localhost:36717/getInfo.html) 17:38:13 INFO - PROCESS | 32125 | __metrics Screen width/height:1600/1200 17:38:13 INFO - PROCESS | 32125 | colorDepth:24 17:38:13 INFO - PROCESS | 32125 | Browser inner width/height: 1024/697 17:38:13 INFO - PROCESS | 32125 | __metrics 17:38:14 INFO - PROCESS | 32125 | 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" 17:38:14 INFO - PROCESS | 32125 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:38:14 INFO - PROCESS | 32125 | console.error: PushService: 17:38:14 INFO - PROCESS | 32125 | stateChangeProcessEnqueue: Error transitioning state 17:38:14 INFO - PROCESS | 32125 | UnknownError 17:38:15 INFO - TEST-INFO | 32125: exit 0 17:38:15 INFO - Browser initialized. 17:38:15 INFO - Running cycle 1/1 for kraken test... 17:38:15 INFO - TEST-INFO | started process 32212 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC_2B8L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:38:27 INFO - PROCESS | 32212 | RSS: Main: 147656704 17:38:27 INFO - PROCESS | 32212 | 17:38:29 INFO - PROCESS | 32212 | Cycle 1(1): loaded http://localhost:36717/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36717/tests/kraken/driver.html?testName=audio-beat-detection) 17:38:30 INFO - PROCESS | 32212 | RSS: Main: 203444224 17:38:30 INFO - PROCESS | 32212 | 17:38:33 INFO - PROCESS | 32212 | Cycle 1(1): loaded http://localhost:36717/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36717/tests/kraken/driver.html?testName=audio-dft) 17:38:33 INFO - PROCESS | 32212 | RSS: Main: 181694464 17:38:33 INFO - PROCESS | 32212 | 17:38:36 INFO - PROCESS | 32212 | Cycle 1(1): loaded http://localhost:36717/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36717/tests/kraken/driver.html?testName=audio-fft) 17:38:37 INFO - PROCESS | 32212 | RSS: Main: 263614464 17:38:37 INFO - PROCESS | 32212 | 17:38:39 INFO - PROCESS | 32212 | Cycle 1(1): loaded http://localhost:36717/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36717/tests/kraken/driver.html?testName=audio-oscillator) 17:38:39 INFO - PROCESS | 32212 | RSS: Main: 175497216 17:38:39 INFO - PROCESS | 32212 | 17:38:41 INFO - PROCESS | 32212 | Cycle 1(1): loaded http://localhost:36717/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36717/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:38:42 INFO - PROCESS | 32212 | RSS: Main: 179048448 17:38:42 INFO - PROCESS | 32212 | 17:38:45 INFO - PROCESS | 32212 | Cycle 1(1): loaded http://localhost:36717/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36717/tests/kraken/driver.html?testName=imaging-darkroom) 17:38:46 INFO - PROCESS | 32212 | RSS: Main: 218583040 17:38:46 INFO - PROCESS | 32212 | 17:38:49 INFO - PROCESS | 32212 | Cycle 1(1): loaded http://localhost:36717/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36717/tests/kraken/driver.html?testName=imaging-desaturate) 17:38:50 INFO - PROCESS | 32212 | RSS: Main: 217997312 17:38:50 INFO - PROCESS | 32212 | 17:38:52 INFO - PROCESS | 32212 | Cycle 1(1): loaded http://localhost:36717/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36717/tests/kraken/driver.html?testName=json-parse-financial) 17:38:53 INFO - PROCESS | 32212 | RSS: Main: 216272896 17:38:53 INFO - PROCESS | 32212 | 17:38:54 INFO - PROCESS | 32212 | Cycle 1(1): loaded http://localhost:36717/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36717/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:38:55 INFO - PROCESS | 32212 | RSS: Main: 179159040 17:38:55 INFO - PROCESS | 32212 | 17:38:57 INFO - PROCESS | 32212 | Cycle 1(1): loaded http://localhost:36717/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36717/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:38:57 INFO - PROCESS | 32212 | RSS: Main: 186167296 17:38:57 INFO - PROCESS | 32212 | 17:39:00 INFO - PROCESS | 32212 | Cycle 1(1): loaded http://localhost:36717/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36717/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:39:00 INFO - PROCESS | 32212 | RSS: Main: 194617344 17:39:00 INFO - PROCESS | 32212 | 17:39:03 INFO - PROCESS | 32212 | Cycle 1(1): loaded http://localhost:36717/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36717/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:39:03 INFO - PROCESS | 32212 | RSS: Main: 204460032 17:39:03 INFO - PROCESS | 32212 | 17:39:06 INFO - PROCESS | 32212 | Cycle 1(1): loaded http://localhost:36717/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36717/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:39:07 INFO - PROCESS | 32212 | RSS: Main: 201023488 17:39:07 INFO - PROCESS | 32212 | 17:39:08 INFO - PROCESS | 32212 | Cycle 1(1): loaded http://localhost:36717/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36717/tests/kraken/driver.html?testName=ai-astar) 17:39:09 INFO - PROCESS | 32212 | RSS: Main: 252731392 17:39:09 INFO - PROCESS | 32212 | 17:39:09 INFO - PROCESS | 32212 | __start_tp_report 17:39:09 INFO - PROCESS | 32212 | _x_x_mozilla_page_load 17:39:09 INFO - PROCESS | 32212 | _x_x_mozilla_page_load_details 17:39:09 INFO - PROCESS | 32212 | |i|pagename|runs| 17:39:09 INFO - PROCESS | 32212 | |0;ai-astar;106;111;114;111;111;113;111;111;111;112 17:39:09 INFO - PROCESS | 32212 | |1;audio-beat-detection;158;116;119;161;121;117;116;120;137;117 17:39:09 INFO - PROCESS | 32212 | |2;audio-dft;160;160;161;159;160;161;160;163;161;160 17:39:09 INFO - PROCESS | 32212 | |3;audio-fft;75;84;76;105;76;78;75;75;90;75 17:39:09 INFO - PROCESS | 32212 | |4;audio-oscillator;83;82;103;83;82;82;94;83;84;109 17:39:09 INFO - PROCESS | 32212 | |5;imaging-gaussian-blur;117;117;117;117;117;118;116;117;117;116 17:39:09 INFO - PROCESS | 32212 | |6;imaging-darkroom;147;147;147;147;147;146;148;147;147;147 17:39:09 INFO - PROCESS | 32212 | |7;imaging-desaturate;96;96;96;96;96;95;95;96;96;96 17:39:09 INFO - PROCESS | 32212 | |8;json-parse-financial;52;51;51;52;52;50;52;51;51;52 17:39:09 INFO - PROCESS | 32212 | |9;json-stringify-tinderbox;66;66;66;67;68;67;67;66;66;72 17:39:09 INFO - PROCESS | 32212 | |10;stanford-crypto-aes;84;87;81;101;81;81;90;85;80;86 17:39:09 INFO - PROCESS | 32212 | |11;stanford-crypto-ccm;127;128;130;125;134;134;124;125;166;135 17:39:09 INFO - PROCESS | 32212 | |12;stanford-crypto-pbkdf2;168;170;166;169;166;166;166;166;170;166 17:39:09 INFO - PROCESS | 32212 | |13;stanford-crypto-sha256-iterative;63;64;63;63;65;62;64;73;64;61 17:39:09 INFO - PROCESS | 32212 | __end_tp_report 17:39:09 INFO - PROCESS | 32212 | __start_cc_report 17:39:09 INFO - PROCESS | 32212 | _x_x_mozilla_cycle_collect,1567 17:39:09 INFO - PROCESS | 32212 | __end_cc_report 17:39:09 INFO - PROCESS | 32212 | __startTimestamp1484617149199__endTimestamp 17:39:09 INFO - PROCESS | 32212 | 17:39:09 INFO - PROCESS | 32212 | ------- Summary: start ------- 17:39:09 INFO - PROCESS | 32212 | Number of tests: 14 17:39:09 INFO - PROCESS | 32212 | 17:39:09 INFO - PROCESS | 32212 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:2.08 (1.9%) stddev-sans-first:1.12 17:39:09 INFO - PROCESS | 32212 | Values: 106.0 111.0 114.0 111.0 111.0 113.0 111.0 111.0 111.0 112.0 17:39:09 INFO - PROCESS | 32212 | 17:39:09 INFO - PROCESS | 32212 | [#1] audio-beat-detection Cycles:10 Average:128.20 Median:120.50 stddev:17.62 (14.6%) stddev-sans-first:15.03 17:39:09 INFO - PROCESS | 32212 | Values: 158.0 116.0 119.0 161.0 121.0 117.0 116.0 120.0 137.0 117.0 17:39:09 INFO - PROCESS | 32212 | 17:39:09 INFO - PROCESS | 32212 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 17:39:09 INFO - PROCESS | 32212 | Values: 160.0 160.0 161.0 159.0 160.0 161.0 160.0 163.0 161.0 160.0 17:39:09 INFO - PROCESS | 32212 | 17:39:09 INFO - PROCESS | 32212 | [#3] audio-fft Cycles:10 Average:80.90 Median:76.00 stddev:9.83 (12.9%) stddev-sans-first:10.19 17:39:09 INFO - PROCESS | 32212 | Values: 75.0 84.0 76.0 105.0 76.0 78.0 75.0 75.0 90.0 75.0 17:39:09 INFO - PROCESS | 32212 | 17:39:09 INFO - PROCESS | 32212 | [#4] audio-oscillator Cycles:10 Average:88.50 Median:83.00 stddev:9.99 (12.0%) stddev-sans-first:10.40 17:39:09 INFO - PROCESS | 32212 | Values: 83.0 82.0 103.0 83.0 82.0 82.0 94.0 83.0 84.0 109.0 17:39:09 INFO - PROCESS | 32212 | 17:39:09 INFO - PROCESS | 32212 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 17:39:09 INFO - PROCESS | 32212 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 116.0 117.0 117.0 116.0 17:39:09 INFO - PROCESS | 32212 | 17:39:09 INFO - PROCESS | 32212 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 17:39:09 INFO - PROCESS | 32212 | Values: 147.0 147.0 147.0 147.0 147.0 146.0 148.0 147.0 147.0 147.0 17:39:09 INFO - PROCESS | 32212 | 17:39:09 INFO - PROCESS | 32212 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:39:09 INFO - PROCESS | 32212 | Values: 96.0 96.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 17:39:09 INFO - PROCESS | 32212 | 17:39:09 INFO - PROCESS | 32212 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:52.00 stddev:0.70 (1.3%) stddev-sans-first:0.71 17:39:09 INFO - PROCESS | 32212 | Values: 52.0 51.0 51.0 52.0 52.0 50.0 52.0 51.0 51.0 52.0 17:39:09 INFO - PROCESS | 32212 | 17:39:09 INFO - PROCESS | 32212 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:1.85 (2.8%) stddev-sans-first:1.92 17:39:09 INFO - PROCESS | 32212 | Values: 66.0 66.0 66.0 67.0 68.0 67.0 67.0 66.0 66.0 72.0 17:39:09 INFO - PROCESS | 32212 | 17:39:09 INFO - PROCESS | 32212 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:84.50 stddev:6.29 (7.4%) stddev-sans-first:6.65 17:39:09 INFO - PROCESS | 32212 | Values: 84.0 87.0 81.0 101.0 81.0 81.0 90.0 85.0 80.0 86.0 17:39:09 INFO - PROCESS | 32212 | 17:39:09 INFO - PROCESS | 32212 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:132.00 stddev:12.35 (9.4%) stddev-sans-first:12.92 17:39:09 INFO - PROCESS | 32212 | Values: 127.0 128.0 130.0 125.0 134.0 134.0 124.0 125.0 166.0 135.0 17:39:09 INFO - PROCESS | 32212 | 17:39:09 INFO - PROCESS | 32212 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:167.00 stddev:1.77 (1.1%) stddev-sans-first:1.86 17:39:09 INFO - PROCESS | 32212 | Values: 168.0 170.0 166.0 169.0 166.0 166.0 166.0 166.0 170.0 166.0 17:39:09 INFO - PROCESS | 32212 | 17:39:09 INFO - PROCESS | 32212 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.00 stddev:3.29 (5.1%) stddev-sans-first:3.46 17:39:09 INFO - PROCESS | 32212 | Values: 63.0 64.0 63.0 63.0 65.0 62.0 64.0 73.0 64.0 61.0 17:39:09 INFO - PROCESS | 32212 | -------- Summary: end -------- 17:39:09 INFO - PROCESS | 32212 | 17:39:10 INFO - TEST-INFO | 32212: exit 0 17:39:10 INFO - TEST-OK | kraken | took 60272ms 17:39:10 INFO - SUITE-END | took 1175s 17:39:10 INFO - Completed test suite (00:19:35) 17:39:10 INFO - javascript benchmark 17:39:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3201.695838895305, 3217.5978002749657, 3240.773145879788, 3251.2034551534875, 3253.365593709225, 5256.316678831756, 5284.048871203182, 5399.541039011684, 5498.835034948953, 5499.422560631131, 5458.590605704578, 5497.587680923917, 5547.889042219153, 5572.5263352615075, 5588.6646801191955, 4890.877728056791, 4918.581920536759, 4951.207806750921, 4962.851114466554, 4985.750712464381, 5001.624878134155, 5008.173651347523, 5025.045241404122, 5029.572486338666, 5032.622553308498, 4750.263709125056, 4797.592204662608, 4813.302071199656, 4909.091818013679, 4950.504949505039, 4845.055214233226, 4902.705837649717, 4932.654714170009, 4944.085344211297, 4944.629152813553, 4867.415910090776, 4870.829520966749, 4872.196087645534, 4891.8777030574165, 4912.066707325596, 5434.402215756264, 5440.075187218183, 5441.564674826044, 5443.673379597237, 5464.098423760075, 5686.857828554319, 5730.512906402961, 5776.046952252873, 5828.883422331572, 5861.589688721791, 5906.881862362771, 5917.704114794286, 5975.402459754033, 5980.521558275327, 5982.0, 5508.7521061552325, 5509.47659972306, 5510.338759348863, 5511.724413779335, 5514.255575497336, 5831.358550559435, 5863.2670916135485, 5956.583039187215, 6008.158857759917, 6022.759089636365, 5675.3757086720425, 5688.488036076773, 5712.171735098471, 5776.451237132465, 5830.38780928005, 5706.885862282731, 5749.13762935563, 5873.706314684248, 5883.264591926009, 5883.646981181143, 5794.420557944172, 5809.883802324014, 5814.3313518945015, 5847.502962248172, 5862.589618726648, 5747.626404283708, 5819.272590926134, 5910.645361278337, 5913.940860591339, 5920.2007728956905, 4530.0, 4546.636269098464, 4546.772661366918, 4581.198290299184, 4623.930641040387, 4057.3102572562143, 4081.20416518776, 4082.6733861291027, 4113.526944401432, 4120.484939382577, 5370.570354371719, 5572.3034620672415, 5573.5819813514145, 5577.525910297589, 5581.162825576115, 5776.335721392094, 5903.1145328200255, 5904.143899134688, 5905.40945905406, 5908.025175845937, 5436.945630543723, 5487.862803429946, 5494.917576236359, 5497.147942068906, 5498.230247765316, 4961.5534601886, 4966.90066198674, 4970.105381031377, 4979.551840334388, 4981.800727970841, 6102.389761023951, 6123.877522449615, 6144.617461071223, 6175.722092505848, 6192.102145188832, 5976.163337132718, 5977.22296101504, 5978.252718410199, 5979.402059793986, 6010.729517171825, 5955.374685657944, 6013.759449622141, 6192.659403732838, 6192.97815860378, 6193.38066193377, 5796.62321949072, 5829.09649004405, 5850.795222167204, 5904.557158213065, 5965.34381218057, 5969.164316995537, 5971.940280597139, 5975.462208401264, 5976.462118409364, 5976.521878249817, 5608.523275521627, 5848.590598658053, 5853.9121913172185, 5856.092305692625, 5861.589688721749, 5700.372958974426, 5701.857453563694, 5719.799807006735, 5753.165790960371, 5823.883522329615, 5703.20155178267, 5753.884922301614, 5754.5684073695475, 5757.05008673581, 5758.424157584208, 5669.376368599368, 5801.390853960443, 5806.883862322646, 5807.535397168132, 5815.621984570989, 5540.889182216414, 5598.35618903815, 5613.354464236665, 5650.491455769001, 5754.741036653444], "value": 5411.122260343025, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.5082403720781, 579.4263678957831, 594.6580716088249, 603.0893351039931, 604.8125081224817, 34861.47707784382, 44761.0, 46562.999999999956, 46674.76662616691, 51032.234516482284, 48750.51249487504, 49295.0, 49309.753451232784, 49353.259701104515, 49356.0, 9010.053944335832, 9200.309976751736, 9204.861927071099, 9209.907900921005, 9216.354855160142, 8624.35317351198, 8828.881068543535, 10570.260081794277, 10821.188410869177, 10825.729356766065, 11042.779144417107, 11109.500072496758, 11112.11103111749, 11115.555377784878, 11130.38782866942, 10989.06592939601, 11054.060404865597, 11068.889311106866, 11080.612178573792, 11085.667429977073, 10811.567537298577, 10881.83677244842, 10883.0, 10893.509792059376, 10896.291741036886, 44284.335734964, 44888.551114488764, 44923.0, 44962.32556511655, 44966.55033449656, 4138.586141385867, 4139.317012692902, 4147.979260103711, 4186.497620285555, 4224.239636865363, 33089.172770680685, 33744.6625533744, 34152.14619634529, 34169.82915085433, 34299.142521436916, 4280.101178752466, 4347.8043488042795, 4395.208862404766, 4499.100179963988, 4590.563896429834, 347647.0, 350103.0, 351585.2420737906, 351708.0, 353752.0, 65503.67248163729, 65677.67161164164, 65911.34088659052, 65952.0, 65962.67018664876, 69300.72342404076, 69362.65318673475, 69607.0, 69830.65084674646, 69918.3008169922, 15747.133907634961, 15985.040897546185, 15995.200239987955, 16005.959612625142, 16059.19704014818, 11926.1651684383, 12243.387830608433, 12856.807147892789, 13015.088943774033, 13023.47906083765, 18747.343842965704, 19064.80935190658, 19171.904140479208, 19727.112279947436, 19927.402177934684, 6486.416222539994, 6547.705353259114, 6580.177477815273, 6687.4984376171005, 6742.359475849787, 918.6325469811995, 945.2438049560325, 945.3524335829978, 946.3801210207325, 961.0821665309612, 31390.686093138775, 33128.80375137175, 33406.0, 33418.49872251918, 33498.66501334956, 986.2307400227834, 1125.285443743229, 1140.0594509529506, 1145.0724912820642, 1163.057923082306, 17259.223334949707, 17589.560260993323, 17634.206460709298, 17635.382761603283, 17733.11334433273, 472283.0, 472738.0, 473473.0, 473508.0, 474193.0, 64527.35472645213, 64835.67582162059, 64884.0, 64895.67552162209, 64922.0, 1465.9853401465848, 1466.9046511976687, 1496.3416096917322, 1498.6777842763859, 1503.323504422992, 30621.0, 32125.51811722779, 32311.192220194684, 32532.51201232031, 32845.83577082195, 53440.0, 55191.72404137954, 55241.0, 55340.0, 55369.0, 372811.0, 373866.0, 374029.0, 374681.0, 375002.0, 37905.43141852819, 42211.577884220766, 42799.7860010698, 42897.571024290606, 43229.56770432255, 43661.0, 47001.0, 49555.50444495509, 49673.0, 55075.724621376634, 41569.58430415778, 43836.34245486384, 44120.0, 44566.77716611396, 45213.77393113145, 42464.36303455512, 43051.35422968595, 43142.56857431511, 44011.77994110009, 44950.0, 41589.0, 41850.37224441575, 43267.56732432635, 43291.35062974121, 43324.0, 35122.47316290309, 36828.45016771609, 37338.25323493569, 37390.8130459346, 38037.0, 28011.299717507227, 28173.43653126885, 28379.57430638501, 28647.57028644614, 28776.712232877402], "value": 21227.66328640866, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.1059983238218, 396.8134976561015, 398.92021595680836, 400.3714168755055, 419.85305143199884, 15230.695386092271, 19482.512937176576, 20231.291904783335, 21027.053782579784, 21035.26376576818, 16257.91871040646, 18432.26270949164, 20033.699494507593, 20193.89903050483, 21339.35981920541, 5639.407862174464, 5917.053271476565, 5924.940750592482, 5926.199963004982, 5953.404659534055, 5684.943150568482, 5805.36141024487, 5829.154772557977, 5848.824535263949, 5852.385499522553, 5818.156367326735, 5852.590318677694, 5856.063029915214, 5857.26784151981, 5858.531317494611, 5665.121906104539, 5777.566682498829, 5813.825585232407, 5854.648721076728, 5855.033919403315, 5128.1282182029145, 5129.435762066169, 5138.46046165151, 5143.048536020848, 5144.408393034774, 23885.522289554112, 24399.756002439924, 24485.0, 24688.0, 24851.875740621363, 2755.9035433759723, 2778.597103419993, 2796.9160925172278, 2815.8310501369983, 2845.9573106403423, 13966.650833729136, 15172.393104275816, 15288.235588220656, 15465.613359665986, 15847.984866013616, 1904.3144467991513, 1937.5931054478576, 1942.5920556683113, 1946.1826033066145, 1948.9610207795906, 94569.52715236449, 95081.52459237659, 95092.52453737757, 96501.5174924128, 98281.81786369544, 10281.126104281071, 10382.169426446017, 10514.106300964351, 10524.421156836448, 10651.467426628638, 14321.78517322241, 14331.713365732627, 14345.354459049368, 14357.353919073457, 14390.928045359706, 6883.0, 7208.459365547605, 7768.805779855549, 8124.796880077927, 8561.82876342482, 8434.746957591282, 8496.405251632326, 8535.445196062235, 8773.561321933877, 8780.648774048967, 6893.620850853251, 6932.0, 6939.479539034492, 7001.754938577227, 7090.468214883905, 1785.9285628574971, 1786.2129492958736, 1808.3489943620286, 1864.3008871673123, 1893.422506135642, 858.4076986879033, 874.1957399192758, 882.3955590420583, 889.4840992224495, 905.1175104273412, 19670.70493942592, 20062.297819576244, 21078.683819742717, 21237.575248494944, 21269.893650531958, 884.787650963764, 885.1325700813239, 898.1557336104172, 898.5462341517492, 905.9411138275991, 11649.88350116488, 11747.941260293645, 11882.28706277626, 11887.70280742971, 11967.0, 630771.0, 631885.0, 633001.0, 653539.0, 682149.0, 93021.5348923251, 93375.53312233531, 93568.53215734015, 93759.0, 94449.5277523608, 1112.1769890281134, 1118.8769235384102, 1125.9042981346513, 1138.2146319039837, 1143.2625956258166, 17467.650646987244, 17486.213120409357, 17972.460826175236, 17996.820031799514, 18394.1722622485, 42659.360109599, 43110.0, 43228.78385608052, 43243.56756432395, 43646.56353436425, 54941.175882361, 55197.72401137969, 55950.0, 56037.43962560322, 57328.71335643295, 7821.491603045783, 8021.959890200512, 8126.83746325082, 8277.793055173668, 8457.746267611981, 13915.652108697364, 14017.929910350791, 14060.226687532284, 14110.0, 14159.36282867294, 11895.881041189477, 11908.34504102248, 12033.63899083029, 12211.450484728031, 12278.75442491163, 11177.944110279723, 11900.642980710592, 12210.26738395699, 12379.93810030944, 12440.813387799371, 12511.874881251435, 12603.432845521791, 12610.87389126097, 12619.36903154857, 12637.914744067493, 7946.364290856602, 8944.37389382737, 9023.729288121367, 9230.75385322759, 9360.017198194364, 10347.896521034694, 11607.419629018346, 11808.0, 11921.0, 12176.33030183313], "value": 9640.078418719304, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1462.6708990477136, 1464.3776395032116, 1479.3047267784145, 1480.4892312152308, 1481.511101336559, 7876.645550950207, 8305.0, 8311.251987321133, 8315.168483151698, 8331.416800823945, 7361.337479626833, 7564.773056808291, 8159.836803263931, 8171.795705107375, 8380.32957363411, 2336.2991102669175, 2368.7631236876346, 2372.0, 2374.5844477216506, 2375.3705268103968, 2192.7039849620255, 2253.0987604957986, 2259.8418110732255, 2261.457250259942, 2263.5246598214394, 2350.8589484630975, 2366.4438856868624, 2381.1665916929023, 2381.535600557892, 2385.5825230584664, 2317.050009496107, 2325.767423257678, 2326.755690652474, 2342.7540108288727, 2349.6240601503678, 2260.446190683293, 2288.5766133265397, 2290.5189910118893, 2290.7480177180496, 2299.1608063056865, 8573.271271941892, 8633.007204171538, 8636.136386361377, 8640.092790257058, 8641.179087986631, 5223.138182199932, 5381.327334083239, 5388.218708287315, 5396.730163491809, 5408.756605952742, 3406.403879321109, 3464.2725027744204, 3669.7798132112157, 3684.6868016218655, 3704.0, 1358.2325985817981, 1363.9386227619782, 1375.9931200344033, 1401.3133564553295, 1529.1360381384482, 11528.365939873303, 11571.247868888495, 11575.36335501547, 11597.884021159849, 11617.419129043514, 4707.670463067621, 4731.4795372509, 4905.852824415273, 4914.778834952435, 4928.507149285043, 9289.72130836076, 9365.203957663538, 9372.0, 9390.389624674373, 9393.859092113487, 5394.811181608625, 5395.757190926418, 5399.946000540023, 5401.2985909439185, 5405.405405405402, 4126.814293356806, 4956.752162391866, 5014.924776128361, 5079.212722028018, 5105.361829771278, 3782.924341513154, 3851.114243723959, 3868.6131386861653, 3880.689544836406, 3905.921881562353, 1167.620523329921, 1174.277819141222, 1175.9176857619884, 1181.8490347567517, 1184.7156682396162, 933.6172169410645, 934.3833070173789, 936.5598168860624, 945.8628498867625, 958.8609651600478, 5216.7913283469, 5869.148973398833, 5886.823395298148, 5922.881542369215, 6245.96877015612, 1004.6232662751469, 1017.1100287248657, 1027.5735569738474, 1053.373242920461, 1060.2578195263347, 3960.574193290413, 4008.5590585035625, 4045.7977101144825, 4116.300228961084, 4173.478315210598, 9840.852387214198, 10183.7454063649, 10185.185185185168, 10200.28597998133, 10218.795624087625, 9982.80034399308, 10076.445795481171, 10095.0, 10095.545700443497, 10099.192064634812, 7951.960240198762, 7970.362371010306, 8082.221911179531, 8093.757187284391, 8103.149169337253, 5522.447755224606, 5782.363939966516, 5861.1501332305725, 5898.587098903035, 6023.879522409439, 9388.248940084914, 9580.425174489554, 9589.568469419033, 9639.132478077006, 9702.805943881223, 9873.40759554429, 9967.352122112039, 9985.201183905416, 9992.250581206585, 10011.199104071802, 6238.532110091852, 6404.583702059351, 6942.340477654615, 7158.248383919822, 7282.089738782653, 8320.625571849403, 8396.622152003296, 8480.533570653673, 8481.533515656698, 8485.0, 7313.158986716596, 7340.816479588053, 7455.142658594114, 7509.962450187714, 7556.282153195438, 7314.414846812136, 7374.557526548424, 7378.5941773202985, 7382.151052629017, 7410.258974102547, 6450.870982580228, 6559.704813283318, 6564.015397690385, 6565.606063636197, 6570.178727659043, 5079.593632509316, 5105.795768169231, 5144.6913185209005, 5189.169732842727, 5393.056215162409, 5360.65155764874, 5381.0, 5412.7564259607625, 5476.945230547643, 5677.602567820213], "value": 4570.871743850727, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.13281659159946, 363.40945962810434, 364.8668236093825, 366.0701817383845, 370.4905754587442, 5272.446393128724, 5272.551833094187, 5276.604254680895, 5339.279197308362, 5340.172273297635, 5005.4494005659435, 5071.0, 5167.080599461302, 5173.560247378968, 5243.348345271237, 4109.383592461125, 4124.216398884202, 4125.9174816503655, 4128.958710412895, 4137.213929353428, 4083.7958102094926, 4101.3847922811665, 4107.260693075245, 4138.317177665696, 4148.896277593054, 3958.683305335581, 4015.8755548446484, 4083.9591604084026, 4093.9590604093873, 4123.3196522573735, 4102.487189101363, 4104.651104656108, 4107.876763697094, 4111.259973204822, 4118.485189351346, 3697.8890633281044, 3705.3330400527893, 3709.332320182366, 3710.8330125144435, 3719.79541125238, 4953.876153096166, 5059.165237735806, 5112.693238405707, 5177.326947496801, 5190.584753219733, 4758.762061896891, 4768.5946694531, 4769.713817170981, 4770.761461926924, 4783.808647654089, 5475.260839786618, 5490.6431081979545, 5495.780168793243, 5506.174073888908, 5528.944710552883, 3685.1892583631557, 3849.6727778138893, 3874.496315478998, 4115.71190016699, 4116.567760385176, 5673.971630141823, 5693.925280348607, 5703.429657034263, 5706.258186435778, 5707.800226992035, 3955.3275943089743, 3956.9010774730286, 3975.8807235782974, 3980.800959951991, 3983.2830090583975, 3941.881743547698, 4000.419939108871, 4018.176273863851, 4022.7988600569856, 4026.295398305285, 4579.862604121815, 4599.33309670096, 4600.194965880957, 4604.861854144381, 4606.239970404846, 5484.8354549363585, 5500.532454741392, 5507.0, 5511.5039646432015, 5512.972435137799, 1300.7138429545485, 1332.2938842413537, 1332.6868185976289, 1334.0989090545934, 1343.7312537492542, 901.3285102598475, 901.6348378906554, 915.2906497464518, 916.4043371808378, 918.3892711347013, 5098.648858052619, 5104.770285337095, 5107.361579802525, 5142.717150556755, 5149.948500515022, 5454.563634909197, 5484.61607687466, 5494.642848214853, 5535.806246781343, 5541.9168712469345, 4923.581495572845, 4991.251312303111, 5043.5965122790085, 5083.898322033612, 5100.285959965608, 2885.0, 2894.5658151277476, 2895.406441679451, 2896.493113705093, 2901.854907254671, 5395.974764794676, 5611.466910643482, 5623.5097699109765, 5640.5487560995025, 5653.0, 5596.468335508202, 5607.691576963224, 5609.5792815539, 5615.697563998741, 5616.595851037241, 5586.636868603609, 5607.691576963306, 5622.345475440996, 5624.521915637135, 5631.690257035739, 5249.160134378634, 5421.349438067457, 5435.809746658848, 5442.210879422382, 5443.938432005721, 5385.299911011543, 5387.353517577916, 5408.675479471244, 5414.864628384322, 5414.891702166014, 5371.946280537145, 5550.69471179089, 5574.5261652758345, 5622.116590942081, 5626.971865140648, 3724.7578907370935, 3775.3393156198103, 3780.8865734028022, 3781.489498917611, 3788.1287303920803, 5353.384360798558, 5393.7033463159905, 5488.615796894179, 5500.80747173847, 5628.324601047901, 5495.505404513613, 5522.30971128609, 5524.0, 5538.6122971391615, 5542.861428464321, 5240.213967904845, 5520.917186242129, 5529.391766905717, 5529.474699903502, 5532.529734972572, 5493.478119578634, 5496.7526461310135, 5497.835064948058, 5504.201890725903, 5529.391766905556, 5482.5613950883035, 5519.199716041071, 5523.59148417151, 5538.307711536058, 5540.750666219949, 5114.360704911886, 5324.866878328073, 5364.839054828361, 5366.758495867617, 5395.649282796606], "value": 4150.464217663925, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [778.6612823421812, 788.4283894176726, 812.9268365847076, 860.3160487412508, 873.2664561768114, 15656.21718914054, 17330.393436229733, 17340.82659173408, 17345.826541734594, 17348.739768903477, 15510.224488775544, 15677.529674109766, 15680.215989200522, 15686.607834804136, 15688.0, 642.1074706158444, 646.8706258748269, 722.0360818307565, 737.5722081192895, 739.1758189618563, 749.1609397474808, 757.2541047068632, 761.6382218446222, 761.77146855943, 761.889526018727, 803.8673618852882, 804.9839003219932, 805.480465100013, 806.1696452653777, 806.8386322735447, 677.5494296293009, 679.5073571660506, 800.0918956983836, 800.4236949396454, 800.7077416742876, 558.062455075473, 561.6910699115512, 565.3244372974298, 579.1370857422453, 580.2862479150626, 15773.0, 16143.838561614351, 16182.919085404616, 16275.755863662054, 16282.51152465428, 14724.116553006854, 15004.0, 15142.697146057017, 15659.608509787233, 15773.211339432983, 12759.923448392105, 12773.680657983625, 12835.422405991752, 12836.358182090951, 12899.93550032244, 3843.6348546888003, 4347.630451411634, 4369.4319738434115, 4426.513083560806, 4490.663200259961, 82087.0, 82395.52813415547, 82803.58598206971, 83309.58345208236, 83683.2342544587, 11407.0, 11508.309501429942, 11509.712257193638, 11647.359395233343, 11685.0, 21753.45616359572, 21856.562868742538, 21858.672119918214, 21964.341069767932, 22102.88948555247, 8125.228103330174, 8249.175082491704, 8268.793280168044, 8575.099614540508, 8586.141385861489, 4612.308153776893, 4646.395968524071, 4706.623470122382, 4715.056988602293, 4799.232122860326, 3699.130704284491, 3811.9809400953372, 3817.351050321452, 3818.9809050955123, 3823.636754508317, 629.6064959400375, 647.8315637934077, 647.8866198415259, 648.0279580629057, 648.060312546809, 764.9923500764921, 776.9650365733555, 787.8778789287669, 787.9369650427952, 796.9800754981172, 10647.733806654896, 10712.46437678113, 11172.162087843282, 11352.886471135349, 11357.318560886208, 606.548121649374, 622.3745136138152, 632.6362341653568, 642.1363266406676, 648.1671052697261, 4859.538343857328, 5194.506521880416, 5197.194434862602, 5257.973710131425, 5338.679679219182, 58026.41973580295, 60246.698766505884, 71101.0, 74781.25218747852, 74892.25107748853, 67907.0, 69012.30987690159, 69425.0, 70877.2912270881, 70900.64549677321, 62862.37137628657, 63001.0, 63261.0, 63524.68237658782, 65552.67223663851, 10098.94950525272, 10821.891781082088, 10893.56425742993, 10989.747101843943, 11364.54541818318, 38182.0, 38568.6143138565, 39502.40746388749, 41137.58862411457, 41181.382279266436, 53134.46865531295, 53292.73353633207, 53518.46481535135, 55200.17199741927, 56337.0, 13175.538856139989, 13462.0, 13465.730685386434, 13762.380692869045, 13924.512642057885, 14374.907090827757, 14539.709205816036, 15025.699486010437, 15084.924575377054, 15513.37946482128, 10991.340519568852, 13598.184108953494, 13770.449182032606, 14146.929265353607, 14558.344874480885, 12658.620241392773, 12662.936685316514, 12811.762660507016, 12939.805902911652, 13271.898533492104, 12415.0, 12548.874511255135, 13175.275359854917, 13295.335233238493, 13384.330783460593, 11631.76736465283, 11652.721118820145, 11769.764604707687, 11834.467448964646, 11945.581904633296, 10321.432321222404, 11238.606648767254, 11425.2002359834, 11621.825672614748, 11721.296722196696], "value": 7316.694252438524, "unit": "score"}], "name": "dromaeo_css", "value": 7319.0533004400995, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 111.0, 114.0, 111.0, 111.0, 113.0, 111.0, 111.0, 111.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 116.0, 119.0, 161.0, 121.0, 117.0, 116.0, 120.0, 137.0, 117.0], "value": 128.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 159.0, 160.0, 161.0, 160.0, 163.0, 161.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 84.0, 76.0, 105.0, 76.0, 78.0, 75.0, 75.0, 90.0, 75.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 103.0, 83.0, 82.0, 82.0, 94.0, 83.0, 84.0, 109.0], "value": 88.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 148.0, 147.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 52.0, 52.0, 50.0, 52.0, 51.0, 51.0, 52.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 68.0, 67.0, 67.0, 66.0, 66.0, 72.0], "value": 67.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 81.0, 101.0, 81.0, 81.0, 90.0, 85.0, 80.0, 86.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 128.0, 130.0, 125.0, 134.0, 134.0, 124.0, 125.0, 166.0, 135.0], "value": 132.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 170.0, 166.0, 169.0, 166.0, 166.0, 166.0, 166.0, 170.0, 166.0], "value": 167.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 65.0, 62.0, 64.0, 73.0, 64.0, 61.0], "value": 64.2, "unit": "score"}], "name": "kraken", "value": 1497.2999999999997, "alertThreshold": 2.0}]} 17:39:10 INFO - Return code: 0 17:39:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:39:10 ERROR - # TBPL SUCCESS # 17:39:10 INFO - Running post-action listener: _resource_record_post_action 17:39:10 INFO - [mozharness: 2017-01-17 01:39:10.515470Z] Finished run-tests step (success) 17:39:10 INFO - Running post-run listener: _resource_record_post_run 17:39:10 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 12288; Write bytes: 421466112; Read time: 204; Write time: 273676 17:39:10 INFO - TinderboxPrint: CPU usage
13.1% 17:39:10 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 204 17:39:10 INFO - TinderboxPrint: I/O write bytes / time
421,466,112 / 273,676 17:39:10 INFO - TinderboxPrint: CPU idle
8,277.0 (86.9%) 17:39:10 INFO - TinderboxPrint: CPU user
1,200.5 (12.6%) 17:39:10 INFO - TinderboxPrint: Swap in / out
0 / 0 17:39:10 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 123187200; Read time: 100; Write time: 110504 17:39:10 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 297709568; Read time: 104; Write time: 163136 17:39:11 INFO - Running post-run listener: _upload_blobber_files 17:39:11 INFO - Blob upload gear active. 17:39:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:39:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:39:11 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'] 17:39:11 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 17:39:11 INFO - (blobuploader) - INFO - Open directory for files ... 17:39:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:39:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:39:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:39:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:39:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:39:12 INFO - (blobuploader) - INFO - Done attempting. 17:39:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:39:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:39:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:39:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:39:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:39:15 INFO - (blobuploader) - INFO - Done attempting. 17:39:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:39:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:39:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:39:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:39:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:39:16 INFO - (blobuploader) - INFO - Done attempting. 17:39:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:39:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:39:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:39:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:39:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:39:17 INFO - (blobuploader) - INFO - Done attempting. 17:39:17 INFO - (blobuploader) - INFO - Iteration through files over. 17:39:17 INFO - Return code: 0 17:39:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:39:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:39:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9387b660c5abb626e724e1aa29287715d81f628079eced31104e415fee1bde1038a0c8889c34b95f28adb47456d40188bbe25627b8ed46d3d4e86f5bac054424", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/247d5d9ba92ba1876a6928d6e9c75a4113774e9ed54b30749333523ca3bbd29146bcad965fa1d1c955eff10596f0835b5de60b189e546b0030217257608964bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f0d57c8a767570bd970c083757617b9b613ce44485d709f275c276bb5bdfe60bbf83023e11ff2a41c4b28f0558b7eff6e55b39ce6016b292d8d0ea94e5c4b5fa", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/640e1c654b951005d73c6f5231707f06f3035d666c5df3d84cd8c5088e1d4d690d3930149653b81d6b9de931eeb0fa027fd6ed8573d72159d3cc2b6a4edc53c1"} 17:39:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:39:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:39:17 INFO - Contents: 17:39:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9387b660c5abb626e724e1aa29287715d81f628079eced31104e415fee1bde1038a0c8889c34b95f28adb47456d40188bbe25627b8ed46d3d4e86f5bac054424", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/247d5d9ba92ba1876a6928d6e9c75a4113774e9ed54b30749333523ca3bbd29146bcad965fa1d1c955eff10596f0835b5de60b189e546b0030217257608964bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f0d57c8a767570bd970c083757617b9b613ce44485d709f275c276bb5bdfe60bbf83023e11ff2a41c4b28f0558b7eff6e55b39ce6016b292d8d0ea94e5c4b5fa", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/640e1c654b951005d73c6f5231707f06f3035d666c5df3d84cd8c5088e1d4d690d3930149653b81d6b9de931eeb0fa027fd6ed8573d72159d3cc2b6a4edc53c1"} 17:39:17 INFO - Running post-run listener: copy_logs_to_upload_dir 17:39:17 INFO - Copying logs to upload dir... 17:39:17 INFO - mkdir: /builds/slave/test/build/upload/logs 17:39:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.221215 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-16 17:39:17.208235) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 17:39:17.211995) ========= 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=ed14279e38b05397cf4aa391000001a4-1484611047.118991-845591504 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/9387b660c5abb626e724e1aa29287715d81f628079eced31104e415fee1bde1038a0c8889c34b95f28adb47456d40188bbe25627b8ed46d3d4e86f5bac054424", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/247d5d9ba92ba1876a6928d6e9c75a4113774e9ed54b30749333523ca3bbd29146bcad965fa1d1c955eff10596f0835b5de60b189e546b0030217257608964bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f0d57c8a767570bd970c083757617b9b613ce44485d709f275c276bb5bdfe60bbf83023e11ff2a41c4b28f0558b7eff6e55b39ce6016b292d8d0ea94e5c4b5fa", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/640e1c654b951005d73c6f5231707f06f3035d666c5df3d84cd8c5088e1d4d690d3930149653b81d6b9de931eeb0fa027fd6ed8573d72159d3cc2b6a4edc53c1"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484609717/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011431 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484609717/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/9387b660c5abb626e724e1aa29287715d81f628079eced31104e415fee1bde1038a0c8889c34b95f28adb47456d40188bbe25627b8ed46d3d4e86f5bac054424", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/247d5d9ba92ba1876a6928d6e9c75a4113774e9ed54b30749333523ca3bbd29146bcad965fa1d1c955eff10596f0835b5de60b189e546b0030217257608964bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f0d57c8a767570bd970c083757617b9b613ce44485d709f275c276bb5bdfe60bbf83023e11ff2a41c4b28f0558b7eff6e55b39ce6016b292d8d0ea94e5c4b5fa", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/640e1c654b951005d73c6f5231707f06f3035d666c5df3d84cd8c5088e1d4d690d3930149653b81d6b9de931eeb0fa027fd6ed8573d72159d3cc2b6a4edc53c1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 17:39:17.237260) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 17:39:17.237597) ========= 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=ed14279e38b05397cf4aa391000001a4-1484611047.118991-845591504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 17:39:17.320570) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 17:39:17.320899) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 17:39:17.321450) ========= ========= Total master_lag: 0.16 =========