builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1481258502.36 results: success (0) buildid: 20161208202745 builduid: 7111e505dcd8437f90479205494db5e8 revision: b57b890350b0e607b4d9b4ca266a761d20fae15e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-08 20:41:42.357602) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-08 20:41:42.358079) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-08 20:41:42.358363) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-08 20:41:42.372684) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 20:41:42.373018) ========= 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=337fe3f4b1febe37b85fccc40000019e-1481258501.324272-915262330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-08 20:41:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 25.7M=0s 2016-12-08 20:41:43 (25.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119045 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 20:41:42.505883) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 20:41:42.506219) ========= 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=337fe3f4b1febe37b85fccc40000019e-1481258501.324272-915262330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016525 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 20:41:42.555961) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 20:41:42.556336) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev b57b890350b0e607b4d9b4ca266a761d20fae15e --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 b57b890350b0e607b4d9b4ca266a761d20fae15e --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=337fe3f4b1febe37b85fccc40000019e-1481258501.324272-915262330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-08 20:41:43,158 truncating revision to first 12 chars 2016-12-08 20:41:43,158 Setting DEBUG logging. 2016-12-08 20:41:43,159 attempt 1/10 2016-12-08 20:41:43,159 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/b57b890350b0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-08 20:41:43,491 unpacking tar archive at: mozilla-inbound-b57b890350b0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.648372 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 20:41:43.218156) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-08 20:41:43.218468) ========= script_repo_revision: b57b890350b0e607b4d9b4ca266a761d20fae15e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-08 20:41:43.218871) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-08 20:41:43.219164) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-08 20:41:43.227469) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-12-08 20:41:43.227806) ========= /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=337fe3f4b1febe37b85fccc40000019e-1481258501.324272-915262330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:41:43 INFO - MultiFileLogger online at 20161208 20:41:43 in /builds/slave/test 20:41:43 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 20:41:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:41:43 INFO - {'append_to_log': False, 20:41:43 INFO - 'base_work_dir': '/builds/slave/test', 20:41:43 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 20:41:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:41:43 INFO - 'branch': 'Mozilla-Inbound', 20:41:43 INFO - 'buildbot_json_path': 'buildprops.json', 20:41:43 INFO - 'config_files': ('talos/linux_config.py',), 20:41:43 INFO - 'default_actions': ('clobber', 20:41:43 INFO - 'read-buildbot-config', 20:41:43 INFO - 'download-and-extract', 20:41:43 INFO - 'populate-webroot', 20:41:43 INFO - 'create-virtualenv', 20:41:43 INFO - 'install', 20:41:43 INFO - 'run-tests'), 20:41:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:41:43 INFO - 'download_minidump_stackwalk': True, 20:41:43 INFO - 'download_symbols': 'ondemand', 20:41:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:41:43 INFO - 'tooltool.py': '/tools/tooltool.py', 20:41:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:41:43 INFO - '/tools/misc-python/virtualenv.py')}, 20:41:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:41:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:41:43 INFO - 'installer_path': 'installer.exe', 20:41:43 INFO - 'log_level': 'info', 20:41:43 INFO - 'log_name': 'talos', 20:41:43 INFO - 'log_to_console': True, 20:41:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:41:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:41:43 INFO - 'opt_config_files': (), 20:41:43 INFO - 'pip_index': False, 20:41:43 INFO - 'sps_profile': False, 20:41:43 INFO - 'sps_profile_interval': 0, 20:41:43 INFO - 'suite': 'dromaeojs', 20:41:43 INFO - 'system_bits': '32', 20:41:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:41:43 INFO - 'title': 'talos-linux64-ix-060', 20:41:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:41:43 INFO - 'use_talos_json': True, 20:41:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:41:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:41:43 INFO - 'work_dir': 'build'} 20:41:43 INFO - [mozharness: 2016-12-09 04:41:43.930398Z] Running clobber step. 20:41:43 INFO - Running pre-action listener: _resource_record_pre_action 20:41:43 INFO - Running main action method: clobber 20:41:43 INFO - rmtree: /builds/slave/test/build 20:41:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:41:44 INFO - Running post-action listener: _resource_record_post_action 20:41:44 INFO - [mozharness: 2016-12-09 04:41:44.959018Z] Finished clobber step (success) 20:41:44 INFO - [mozharness: 2016-12-09 04:41:44.959118Z] Running read-buildbot-config step. 20:41:44 INFO - Running pre-action listener: _resource_record_pre_action 20:41:44 INFO - Running main action method: read_buildbot_config 20:41:44 INFO - Using buildbot properties: 20:41:44 INFO - { 20:41:44 INFO - "project": "", 20:41:44 INFO - "product": "firefox", 20:41:44 INFO - "script_repo_revision": "production", 20:41:44 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 20:41:44 INFO - "repository": "", 20:41:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 20:41:44 INFO - "buildid": "20161208202745", 20:41:44 INFO - "stage_platform": "linux64-pgo", 20:41:44 INFO - "basedir": "/builds/slave/test", 20:41:44 INFO - "buildnumber": 2254, 20:41:44 INFO - "platform": "ubuntu64_hw", 20:41:44 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:41:44 INFO - "slavebuilddir": "test", 20:41:44 INFO - "branch": "mozilla-inbound", 20:41:44 INFO - "revision": "b57b890350b0e607b4d9b4ca266a761d20fae15e", 20:41:44 INFO - "slavename": "talos-linux64-ix-060", 20:41:44 INFO - "builduid": "7111e505dcd8437f90479205494db5e8", 20:41:44 INFO - "repo_path": "integration/mozilla-inbound" 20:41:44 INFO - } 20:41:44 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481250982/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 20:41:44 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481250982/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 20:41:44 INFO - Running post-action listener: _resource_record_post_action 20:41:44 INFO - [mozharness: 2016-12-09 04:41:44.961462Z] Finished read-buildbot-config step (success) 20:41:44 INFO - [mozharness: 2016-12-09 04:41:44.961559Z] Running download-and-extract step. 20:41:44 INFO - Running pre-action listener: _resource_record_pre_action 20:41:44 INFO - Running main action method: download_and_extract 20:41:44 INFO - mkdir: /builds/slave/test/build/tests 20:41:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:41:44 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481250982/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 20:41:44 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481250982/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 20:41:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481250982/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 20:41:45 INFO - Downloaded 1361 bytes. 20:41:45 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 20:41:45 INFO - Using the following test package requirements: 20:41:45 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 20:41:45 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:41:45 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:41:45 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:45 INFO - u'jsshell-linux-x86_64.zip'], 20:41:45 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:41:45 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 20:41:45 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:41:45 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:41:45 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:41:45 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:41:45 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:41:45 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/1481250982/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 20:41:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481250982/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:41:45 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481250982/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:41:49 INFO - Expected file size: 21784889 20:41:49 INFO - Obtained file size: 21784889 20:41:53 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 20:41:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481250982/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 20:41:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481250982/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:41:53 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481250982/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:41:54 INFO - Expected file size: 21784889 20:41:54 INFO - Obtained file size: 21784889 20:41:58 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/1481250982/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 20:41:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481250982/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:41:58 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481250982/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 20:42:02 INFO - Expected file size: 14409734 20:42:02 INFO - Obtained file size: 14409734 20:42: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')]} 20:42:02 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481250982/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:42:02 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481250982/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 20:42:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481250982/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 20:42:08 INFO - Downloaded 59853636 bytes. 20:42:08 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481250982/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:42:08 INFO - mkdir: /builds/slave/test/properties 20:42:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:42:08 INFO - Writing to file /builds/slave/test/properties/build_url 20:42:08 INFO - Contents: 20:42:08 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481250982/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:42:09 INFO - Running post-action listener: _resource_record_post_action 20:42:09 INFO - Running post-action listener: set_extra_try_arguments 20:42:09 INFO - [mozharness: 2016-12-09 04:42:09.374546Z] Finished download-and-extract step (success) 20:42:09 INFO - [mozharness: 2016-12-09 04:42:09.374774Z] Running populate-webroot step. 20:42:09 INFO - Running pre-action listener: _resource_record_pre_action 20:42:09 INFO - Running main action method: populate_webroot 20:42:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:42:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:42:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:42:09 INFO - '--tppagecycles', 20:42:09 INFO - '7'], 20:42:09 INFO - 'tests': ['tsvgm']}}, 20:42:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:42:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:42:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:42:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:42:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:42:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:42:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:42:09 INFO - 'talos_options': ['--disable-e10s'], 20:42:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:42:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:42:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:42:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:42:09 INFO - 'talos_options': ['--disable-e10s'], 20:42:09 INFO - 'tests': ['damp', 'tps']}, 20:42:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:42:09 INFO - 'tests': ['damp', 'tps']}, 20:42:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:42:09 INFO - 'tests': ['dromaeo_dom']}, 20:42:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:42:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:42:09 INFO - 'tests': ['basic_compositor_video']}, 20:42:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:42:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:42:09 INFO - 'tests': ['a11yr', 20:42:09 INFO - 'ts_paint', 20:42:09 INFO - 'tpaint', 20:42:09 INFO - 'sessionrestore', 20:42:09 INFO - 'sessionrestore_no_auto_restore', 20:42:09 INFO - 'tabpaint']}, 20:42:09 INFO - 'other-e10s': {'tests': ['a11yr', 20:42:09 INFO - 'ts_paint', 20:42:09 INFO - 'tpaint', 20:42:09 INFO - 'sessionrestore', 20:42:09 INFO - 'sessionrestore_no_auto_restore', 20:42:09 INFO - 'tabpaint']}, 20:42:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:42:09 INFO - 'ts_paint', 20:42:09 INFO - 'tpaint', 20:42:09 INFO - 'sessionrestore', 20:42:09 INFO - 'sessionrestore_no_auto_restore', 20:42:09 INFO - 'tabpaint']}, 20:42:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:42:09 INFO - 'ts_paint', 20:42:09 INFO - 'tpaint', 20:42:09 INFO - 'sessionrestore', 20:42:09 INFO - 'sessionrestore_no_auto_restore', 20:42:09 INFO - 'tabpaint']}, 20:42:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:42:09 INFO - 'tests': ['a11yr', 20:42:09 INFO - 'ts_paint', 20:42:09 INFO - 'tpaint', 20:42:09 INFO - 'sessionrestore', 20:42:09 INFO - 'sessionrestore_no_auto_restore', 20:42:09 INFO - 'tabpaint']}, 20:42:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:42:09 INFO - 'tests': ['a11yr', 20:42:09 INFO - 'ts_paint', 20:42:09 INFO - 'tpaint', 20:42:09 INFO - 'sessionrestore', 20:42:09 INFO - 'sessionrestore_no_auto_restore', 20:42:09 INFO - 'tabpaint']}, 20:42:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:42:09 INFO - 'tests': ['tsvgx', 20:42:09 INFO - 'tsvgr_opacity', 20:42:09 INFO - 'tart', 20:42:09 INFO - 'tscrollx', 20:42:09 INFO - 'cart', 20:42:09 INFO - 'tsvg_static']}, 20:42:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:42:09 INFO - 'tsvgr_opacity', 20:42:09 INFO - 'tart', 20:42:09 INFO - 'tscrollx', 20:42:09 INFO - 'cart', 20:42:09 INFO - 'tsvg_static']}, 20:42:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:42:09 INFO - 'talos_options': ['--disable-e10s'], 20:42:09 INFO - 'tests': ['tp5o']}, 20:42:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:42:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:42:09 INFO - 'talos_options': ['--disable-e10s', 20:42:09 INFO - '--xperf_path', 20:42:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:42:09 INFO - 'tests': ['tp5n']}, 20:42:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:42:09 INFO - 'talos_options': ['--xperf_path', 20:42:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:42:09 INFO - 'tests': ['tp5n']}}, 20:42:09 INFO - 'talos.zip': {'path': '', 20:42:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:42:09 INFO - Running post-action listener: _resource_record_post_action 20:42:09 INFO - [mozharness: 2016-12-09 04:42:09.389687Z] Finished populate-webroot step (success) 20:42:09 INFO - [mozharness: 2016-12-09 04:42:09.389775Z] Running create-virtualenv step. 20:42:09 INFO - Running pre-action listener: _resource_record_pre_action 20:42:09 INFO - Running main action method: create_virtualenv 20:42:09 INFO - Creating virtualenv /builds/slave/test/build/venv 20:42:09 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 20:42:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:42:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:42:09 INFO - Using real prefix '/usr' 20:42:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:42:09 INFO - Installing distribute.............................................................................................................................................................................................done. 20:42:11 INFO - Installing pip.................done. 20:42:11 INFO - Return code: 0 20:42:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:42:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:42:12 INFO - Reading from file tmpfile_stdout 20:42:12 INFO - Output received: 20:42:12 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) 20:42:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:42: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')]} 20:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42: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')]} 20:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:12 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 0x7fd1559dce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1520a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16be120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ef20>, '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 0x16bbc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bbf90>, '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': '337fe3f4b1febe37b85fccc40000019e-1481258501.324272-915262330', '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 20:42:12 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 20:42:12 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 20:42:12 INFO - Using env: {'DISPLAY': ':0', 20:42:12 INFO - 'HOME': '/home/cltbld', 20:42:12 INFO - 'LANG': 'en_US.UTF-8', 20:42:12 INFO - 'LANGUAGE': 'en_US:en', 20:42:12 INFO - 'LOGNAME': 'cltbld', 20:42:12 INFO - 'MAIL': '/var/mail/cltbld', 20:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:12 INFO - 'MOZ_NO_REMOTE': '1', 20:42:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:12 INFO - 'NO_EM_RESTART': '1', 20:42:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:12 INFO - 'PWD': '/builds/slave/test', 20:42:12 INFO - 'SHELL': '/bin/bash', 20:42:12 INFO - 'SHLVL': '1', 20:42:12 INFO - 'TERM': 'linux', 20:42:12 INFO - 'TMOUT': '86400', 20:42:12 INFO - 'USER': 'cltbld', 20:42:12 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1481258501.324272-915262330', 20:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:12 INFO - '_': '/tools/buildbot/bin/python'} 20:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:12 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 20:42:12 INFO - Cleaning up... 20:42:12 INFO - Return code: 0 20:42:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:42: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')]} 20:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42: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')]} 20:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:12 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 0x7fd1559dce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1520a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16be120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ef20>, '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 0x16bbc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bbf90>, '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': '337fe3f4b1febe37b85fccc40000019e-1481258501.324272-915262330', '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 20:42:12 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 20:42:12 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 20:42:12 INFO - Using env: {'DISPLAY': ':0', 20:42:12 INFO - 'HOME': '/home/cltbld', 20:42:12 INFO - 'LANG': 'en_US.UTF-8', 20:42:12 INFO - 'LANGUAGE': 'en_US:en', 20:42:12 INFO - 'LOGNAME': 'cltbld', 20:42:12 INFO - 'MAIL': '/var/mail/cltbld', 20:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:12 INFO - 'MOZ_NO_REMOTE': '1', 20:42:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:12 INFO - 'NO_EM_RESTART': '1', 20:42:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:12 INFO - 'PWD': '/builds/slave/test', 20:42:12 INFO - 'SHELL': '/bin/bash', 20:42:12 INFO - 'SHLVL': '1', 20:42:12 INFO - 'TERM': 'linux', 20:42:12 INFO - 'TMOUT': '86400', 20:42:12 INFO - 'USER': 'cltbld', 20:42:12 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1481258501.324272-915262330', 20:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:12 INFO - '_': '/tools/buildbot/bin/python'} 20:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:12 INFO - Downloading/unpacking psutil>=3.1.1 20:42:12 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 20:42:12 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 20:42:12 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 20:42:12 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 20:42:12 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 20:42:12 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 20:42:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:42:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:42:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:42:14 INFO - Installing collected packages: psutil 20:42:14 INFO - Running setup.py install for psutil 20:42:14 INFO - building 'psutil._psutil_linux' extension 20:42:14 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 20:42:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:42:14 INFO - building 'psutil._psutil_posix' extension 20:42:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:42:15 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 20:42:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:42:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:42:15 INFO - Successfully installed psutil 20:42:15 INFO - Cleaning up... 20:42:15 INFO - Return code: 0 20:42:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:42:15 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')]} 20:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:15 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')]} 20:42:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:15 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 0x7fd1559dce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1520a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16be120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ef20>, '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 0x16bbc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bbf90>, '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': '337fe3f4b1febe37b85fccc40000019e-1481258501.324272-915262330', '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 20:42:15 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 20:42:15 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 20:42:15 INFO - Using env: {'DISPLAY': ':0', 20:42:15 INFO - 'HOME': '/home/cltbld', 20:42:15 INFO - 'LANG': 'en_US.UTF-8', 20:42:15 INFO - 'LANGUAGE': 'en_US:en', 20:42:15 INFO - 'LOGNAME': 'cltbld', 20:42:15 INFO - 'MAIL': '/var/mail/cltbld', 20:42:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:15 INFO - 'MOZ_NO_REMOTE': '1', 20:42:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:15 INFO - 'NO_EM_RESTART': '1', 20:42:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:15 INFO - 'PWD': '/builds/slave/test', 20:42:15 INFO - 'SHELL': '/bin/bash', 20:42:15 INFO - 'SHLVL': '1', 20:42:15 INFO - 'TERM': 'linux', 20:42:15 INFO - 'TMOUT': '86400', 20:42:15 INFO - 'USER': 'cltbld', 20:42:15 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1481258501.324272-915262330', 20:42:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:15 INFO - '_': '/tools/buildbot/bin/python'} 20:42:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:42:15 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 20:42:15 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 20:42:15 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 20:42:15 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 20:42:15 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 20:42:15 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 20:42:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:42:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:42:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:42:17 INFO - Installing collected packages: mozsystemmonitor 20:42:17 INFO - Running setup.py install for mozsystemmonitor 20:42:17 INFO - Successfully installed mozsystemmonitor 20:42:17 INFO - Cleaning up... 20:42:17 INFO - Return code: 0 20:42:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:42:17 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')]} 20:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:17 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')]} 20:42:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:17 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 0x7fd1559dce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1520a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16be120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ef20>, '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 0x16bbc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bbf90>, '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': '337fe3f4b1febe37b85fccc40000019e-1481258501.324272-915262330', '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 20:42:17 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 20:42:17 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 20:42:17 INFO - Using env: {'DISPLAY': ':0', 20:42:17 INFO - 'HOME': '/home/cltbld', 20:42:17 INFO - 'LANG': 'en_US.UTF-8', 20:42:17 INFO - 'LANGUAGE': 'en_US:en', 20:42:17 INFO - 'LOGNAME': 'cltbld', 20:42:17 INFO - 'MAIL': '/var/mail/cltbld', 20:42:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:17 INFO - 'MOZ_NO_REMOTE': '1', 20:42:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:17 INFO - 'NO_EM_RESTART': '1', 20:42:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:17 INFO - 'PWD': '/builds/slave/test', 20:42:17 INFO - 'SHELL': '/bin/bash', 20:42:17 INFO - 'SHLVL': '1', 20:42:17 INFO - 'TERM': 'linux', 20:42:17 INFO - 'TMOUT': '86400', 20:42:17 INFO - 'USER': 'cltbld', 20:42:17 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1481258501.324272-915262330', 20:42:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:17 INFO - '_': '/tools/buildbot/bin/python'} 20:42:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:18 INFO - Downloading/unpacking jsonschema==2.5.1 20:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:42:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:20 INFO - Downloading functools32-3.2.3-2.tar.gz 20:42:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:42:20 INFO - warning: no files found matching '*.txt' 20:42:20 INFO - no previously-included directories found matching 'build' 20:42:20 INFO - no previously-included directories found matching 'dist' 20:42:20 INFO - no previously-included directories found matching '.git*' 20:42:20 INFO - Installing collected packages: jsonschema, functools32 20:42:20 INFO - Running setup.py install for functools32 20:42:20 INFO - warning: no files found matching '*.txt' 20:42:20 INFO - no previously-included directories found matching 'build' 20:42:20 INFO - no previously-included directories found matching 'dist' 20:42:20 INFO - no previously-included directories found matching '.git*' 20:42:20 INFO - Successfully installed jsonschema functools32 20:42:20 INFO - Cleaning up... 20:42:20 INFO - Return code: 0 20:42:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:42:20 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')]} 20:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:20 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')]} 20:42:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:20 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 0x7fd1559dce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1520a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16be120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ef20>, '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 0x16bbc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bbf90>, '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': '337fe3f4b1febe37b85fccc40000019e-1481258501.324272-915262330', '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 20:42:20 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 20:42:20 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 20:42:20 INFO - Using env: {'DISPLAY': ':0', 20:42:20 INFO - 'HOME': '/home/cltbld', 20:42:20 INFO - 'LANG': 'en_US.UTF-8', 20:42:20 INFO - 'LANGUAGE': 'en_US:en', 20:42:20 INFO - 'LOGNAME': 'cltbld', 20:42:20 INFO - 'MAIL': '/var/mail/cltbld', 20:42:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:20 INFO - 'MOZ_NO_REMOTE': '1', 20:42:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:20 INFO - 'NO_EM_RESTART': '1', 20:42:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:20 INFO - 'PWD': '/builds/slave/test', 20:42:20 INFO - 'SHELL': '/bin/bash', 20:42:20 INFO - 'SHLVL': '1', 20:42:20 INFO - 'TERM': 'linux', 20:42:20 INFO - 'TMOUT': '86400', 20:42:20 INFO - 'USER': 'cltbld', 20:42:20 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1481258501.324272-915262330', 20:42:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:20 INFO - '_': '/tools/buildbot/bin/python'} 20:42:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:42:20 INFO - Cleaning up... 20:42:20 INFO - Return code: 0 20:42:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:42:20 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')]} 20:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:20 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')]} 20:42:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:20 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 0x7fd1559dce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1520a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16be120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ef20>, '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 0x16bbc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bbf90>, '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': '337fe3f4b1febe37b85fccc40000019e-1481258501.324272-915262330', '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 20:42:20 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 20:42:20 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 20:42:20 INFO - Using env: {'DISPLAY': ':0', 20:42:20 INFO - 'HOME': '/home/cltbld', 20:42:20 INFO - 'LANG': 'en_US.UTF-8', 20:42:20 INFO - 'LANGUAGE': 'en_US:en', 20:42:20 INFO - 'LOGNAME': 'cltbld', 20:42:20 INFO - 'MAIL': '/var/mail/cltbld', 20:42:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:20 INFO - 'MOZ_NO_REMOTE': '1', 20:42:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:20 INFO - 'NO_EM_RESTART': '1', 20:42:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:20 INFO - 'PWD': '/builds/slave/test', 20:42:20 INFO - 'SHELL': '/bin/bash', 20:42:20 INFO - 'SHLVL': '1', 20:42:20 INFO - 'TERM': 'linux', 20:42:20 INFO - 'TMOUT': '86400', 20:42:20 INFO - 'USER': 'cltbld', 20:42:20 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1481258501.324272-915262330', 20:42:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:20 INFO - '_': '/tools/buildbot/bin/python'} 20:42:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:20 INFO - Downloading/unpacking blobuploader==1.2.4 20:42:20 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 20:42:20 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 20:42:20 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 20:42:20 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 20:42:20 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 20:42:20 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 20:42:22 INFO - Downloading blobuploader-1.2.4.tar.gz 20:42:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:42:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:42:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:42:23 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 20:42:23 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 20:42:23 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 20:42:23 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 20:42:23 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 20:42:23 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 20:42:23 INFO - Downloading docopt-0.6.1.tar.gz 20:42:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:42:23 INFO - Installing collected packages: blobuploader, requests, docopt 20:42:23 INFO - Running setup.py install for blobuploader 20:42:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:42:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:42:23 INFO - Running setup.py install for requests 20:42:24 INFO - Running setup.py install for docopt 20:42:24 INFO - Successfully installed blobuploader requests docopt 20:42:24 INFO - Cleaning up... 20:42:24 INFO - Return code: 0 20:42:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:42:24 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')]} 20:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:24 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')]} 20:42:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:24 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 0x7fd1559dce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1520a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16be120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ef20>, '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 0x16bbc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bbf90>, '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': '337fe3f4b1febe37b85fccc40000019e-1481258501.324272-915262330', '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 20:42:24 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 20:42:24 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 20:42:24 INFO - Using env: {'DISPLAY': ':0', 20:42:24 INFO - 'HOME': '/home/cltbld', 20:42:24 INFO - 'LANG': 'en_US.UTF-8', 20:42:24 INFO - 'LANGUAGE': 'en_US:en', 20:42:24 INFO - 'LOGNAME': 'cltbld', 20:42:24 INFO - 'MAIL': '/var/mail/cltbld', 20:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:24 INFO - 'MOZ_NO_REMOTE': '1', 20:42:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:24 INFO - 'NO_EM_RESTART': '1', 20:42:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:24 INFO - 'PWD': '/builds/slave/test', 20:42:24 INFO - 'SHELL': '/bin/bash', 20:42:24 INFO - 'SHLVL': '1', 20:42:24 INFO - 'TERM': 'linux', 20:42:24 INFO - 'TMOUT': '86400', 20:42:24 INFO - 'USER': 'cltbld', 20:42:24 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1481258501.324272-915262330', 20:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:24 INFO - '_': '/tools/buildbot/bin/python'} 20:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:42:24 INFO - Running setup.py (path:/tmp/pip-_tOq0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:42:24 INFO - Running setup.py (path:/tmp/pip-fKjadf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:42:24 INFO - Running setup.py (path:/tmp/pip-1OlqZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:42:24 INFO - Running setup.py (path:/tmp/pip-VCkTR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:42:24 INFO - Running setup.py (path:/tmp/pip-OeSRs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:42:24 INFO - Running setup.py (path:/tmp/pip-5QTShY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:42:24 INFO - Running setup.py (path:/tmp/pip-rJC9s8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:42:25 INFO - Running setup.py (path:/tmp/pip-C2lU9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:42:25 INFO - Running setup.py (path:/tmp/pip-wukk_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:42:25 INFO - Running setup.py (path:/tmp/pip-299Hfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:42:25 INFO - Running setup.py (path:/tmp/pip-0bBa0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:42:25 INFO - Running setup.py (path:/tmp/pip-uwXBMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:42:25 INFO - Running setup.py (path:/tmp/pip-NmeeBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:42:25 INFO - Running setup.py (path:/tmp/pip-PI_Oxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:42:25 INFO - Running setup.py (path:/tmp/pip-espLp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:42:25 INFO - Running setup.py (path:/tmp/pip-iqPmGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:42:25 INFO - Running setup.py (path:/tmp/pip-7cgMJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:42:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:42:25 INFO - Running setup.py install for manifestparser 20:42:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:42:25 INFO - Running setup.py install for mozcrash 20:42:25 INFO - Running setup.py install for mozdebug 20:42:26 INFO - Running setup.py install for mozdevice 20:42:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:42:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:42:26 INFO - Running setup.py install for mozfile 20:42:26 INFO - Running setup.py install for mozhttpd 20:42:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:42:26 INFO - Running setup.py install for mozinfo 20:42:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:42:26 INFO - Running setup.py install for mozInstall 20:42:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:42:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:42:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:42:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:42:26 INFO - Running setup.py install for mozleak 20:42:26 INFO - Running setup.py install for mozlog 20:42:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:42:26 INFO - Running setup.py install for moznetwork 20:42:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:42:26 INFO - Running setup.py install for mozprocess 20:42:27 INFO - Running setup.py install for mozprofile 20:42:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:42:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:42:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:42:27 INFO - Running setup.py install for mozrunner 20:42:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:42:27 INFO - Running setup.py install for mozscreenshot 20:42:27 INFO - Running setup.py install for moztest 20:42:27 INFO - Running setup.py install for mozversion 20:42:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:42:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:42:27 INFO - Cleaning up... 20:42:27 INFO - Return code: 0 20:42:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:42:27 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')]} 20:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:27 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')]} 20:42:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:27 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 0x7fd1559dce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1520a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16be120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ef20>, '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 0x16bbc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bbf90>, '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': '337fe3f4b1febe37b85fccc40000019e-1481258501.324272-915262330', '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 20:42:27 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 20:42:27 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 20:42:27 INFO - Using env: {'DISPLAY': ':0', 20:42:27 INFO - 'HOME': '/home/cltbld', 20:42:27 INFO - 'LANG': 'en_US.UTF-8', 20:42:27 INFO - 'LANGUAGE': 'en_US:en', 20:42:27 INFO - 'LOGNAME': 'cltbld', 20:42:27 INFO - 'MAIL': '/var/mail/cltbld', 20:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:27 INFO - 'MOZ_NO_REMOTE': '1', 20:42:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:27 INFO - 'NO_EM_RESTART': '1', 20:42:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:27 INFO - 'PWD': '/builds/slave/test', 20:42:27 INFO - 'SHELL': '/bin/bash', 20:42:27 INFO - 'SHLVL': '1', 20:42:27 INFO - 'TERM': 'linux', 20:42:27 INFO - 'TMOUT': '86400', 20:42:27 INFO - 'USER': 'cltbld', 20:42:27 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1481258501.324272-915262330', 20:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:27 INFO - '_': '/tools/buildbot/bin/python'} 20:42:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:42:27 INFO - Running setup.py (path:/tmp/pip-VC7Zc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:42:27 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)) 20:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:42:27 INFO - Running setup.py (path:/tmp/pip-fC2xlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:42:27 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)) 20:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:42:27 INFO - Running setup.py (path:/tmp/pip-ZcAHOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:42:27 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)) 20:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:42:28 INFO - Running setup.py (path:/tmp/pip-6YgVFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:42:28 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)) 20:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:42:28 INFO - Running setup.py (path:/tmp/pip-m1e8n6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:42:28 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)) 20:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:42:28 INFO - Running setup.py (path:/tmp/pip-lggP99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:42:28 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)) 20:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:42:28 INFO - Running setup.py (path:/tmp/pip-Tidcl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:42:28 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)) 20:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:42:28 INFO - Running setup.py (path:/tmp/pip-rYMCep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:42:28 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)) 20:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:42:28 INFO - Running setup.py (path:/tmp/pip-WfQTM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:42:28 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)) 20:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:42:28 INFO - Running setup.py (path:/tmp/pip-Ua8IDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:42:28 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)) 20:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:42:28 INFO - Running setup.py (path:/tmp/pip-Ffu8Z9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:42:28 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)) 20:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:42:28 INFO - Running setup.py (path:/tmp/pip-ZljCVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:42:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:42:28 INFO - Running setup.py (path:/tmp/pip-t6IWWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:42:28 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)) 20:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:42:28 INFO - Running setup.py (path:/tmp/pip-MGjiOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:42:28 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)) 20:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:42:28 INFO - Running setup.py (path:/tmp/pip-HKvuAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:42:28 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)) 20:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:42:28 INFO - Running setup.py (path:/tmp/pip-3rf28m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:42:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:42:28 INFO - Running setup.py (path:/tmp/pip-p2rytd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:42:29 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)) 20:42:29 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)) 20:42:29 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)) 20:42:29 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)) 20:42:29 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)) 20:42:29 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)) 20:42:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:42:29 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 20:42:29 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 20:42:29 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 20:42:29 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 20:42:29 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 20:42:29 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 20:42:30 INFO - Downloading blessings-1.6.tar.gz 20:42:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:42:31 INFO - Installing collected packages: blessings 20:42:31 INFO - Running setup.py install for blessings 20:42:31 INFO - Successfully installed blessings 20:42:31 INFO - Cleaning up... 20:42:31 INFO - Return code: 0 20:42:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:42:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:42:31 INFO - Reading from file tmpfile_stdout 20:42:31 INFO - Current package versions: 20:42:31 INFO - argparse == 1.2.1 20:42:31 INFO - blessings == 1.6 20:42:31 INFO - blobuploader == 1.2.4 20:42:31 INFO - docopt == 0.6.1 20:42:31 INFO - functools32 == 3.2.3-2 20:42:31 INFO - jsonschema == 2.5.1 20:42:31 INFO - manifestparser == 1.1 20:42:31 INFO - mozInstall == 1.12 20:42:31 INFO - mozcrash == 1.0 20:42:31 INFO - mozdebug == 0.1 20:42:31 INFO - mozdevice == 0.49 20:42:31 INFO - mozfile == 1.2 20:42:31 INFO - mozhttpd == 0.7 20:42:31 INFO - mozinfo == 0.9 20:42:31 INFO - mozleak == 0.1 20:42:31 INFO - mozlog == 3.4 20:42:31 INFO - moznetwork == 0.27 20:42:31 INFO - mozprocess == 0.23 20:42:31 INFO - mozprofile == 0.28 20:42:31 INFO - mozrunner == 6.13 20:42:31 INFO - mozscreenshot == 0.1 20:42:31 INFO - mozsystemmonitor == 0.3 20:42:31 INFO - moztest == 0.7 20:42:31 INFO - mozversion == 1.4 20:42:31 INFO - psutil == 3.1.1 20:42:31 INFO - requests == 1.2.3 20:42:31 INFO - wsgiref == 0.1.2 20:42:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:42:31 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')]} 20:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:31 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')]} 20:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:31 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 0x7fd1559dce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1520a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16be120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ef20>, '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 0x16bbc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bbf90>, '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': '337fe3f4b1febe37b85fccc40000019e-1481258501.324272-915262330', '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 20:42:31 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 20:42:31 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 20:42:31 INFO - Using env: {'DISPLAY': ':0', 20:42:31 INFO - 'HOME': '/home/cltbld', 20:42:31 INFO - 'LANG': 'en_US.UTF-8', 20:42:31 INFO - 'LANGUAGE': 'en_US:en', 20:42:31 INFO - 'LOGNAME': 'cltbld', 20:42:31 INFO - 'MAIL': '/var/mail/cltbld', 20:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:31 INFO - 'MOZ_NO_REMOTE': '1', 20:42:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:31 INFO - 'NO_EM_RESTART': '1', 20:42:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:31 INFO - 'PWD': '/builds/slave/test', 20:42:31 INFO - 'SHELL': '/bin/bash', 20:42:31 INFO - 'SHLVL': '1', 20:42:31 INFO - 'TERM': 'linux', 20:42:31 INFO - 'TMOUT': '86400', 20:42:31 INFO - 'USER': 'cltbld', 20:42:31 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1481258501.324272-915262330', 20:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:31 INFO - '_': '/tools/buildbot/bin/python'} 20:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:31 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)) 20:42:31 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)) 20:42:31 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)) 20:42:31 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)) 20:42:31 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)) 20:42:31 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)) 20:42:31 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)) 20:42:31 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)) 20:42:31 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)) 20:42:31 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)) 20:42:31 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)) 20:42:31 INFO - Cleaning up... 20:42:31 INFO - Return code: 0 20:42:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:42:31 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')]} 20:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:31 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')]} 20:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:31 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 0x7fd1559dce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1520a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16be120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ef20>, '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 0x16bbc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bbf90>, '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': '337fe3f4b1febe37b85fccc40000019e-1481258501.324272-915262330', '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 20:42:31 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 20:42:31 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 20:42:31 INFO - Using env: {'DISPLAY': ':0', 20:42:31 INFO - 'HOME': '/home/cltbld', 20:42:31 INFO - 'LANG': 'en_US.UTF-8', 20:42:31 INFO - 'LANGUAGE': 'en_US:en', 20:42:31 INFO - 'LOGNAME': 'cltbld', 20:42:31 INFO - 'MAIL': '/var/mail/cltbld', 20:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:31 INFO - 'MOZ_NO_REMOTE': '1', 20:42:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:31 INFO - 'NO_EM_RESTART': '1', 20:42:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:31 INFO - 'PWD': '/builds/slave/test', 20:42:31 INFO - 'SHELL': '/bin/bash', 20:42:31 INFO - 'SHLVL': '1', 20:42:31 INFO - 'TERM': 'linux', 20:42:31 INFO - 'TMOUT': '86400', 20:42:31 INFO - 'USER': 'cltbld', 20:42:31 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1481258501.324272-915262330', 20:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:31 INFO - '_': '/tools/buildbot/bin/python'} 20:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:42:31 INFO - Cleaning up... 20:42:31 INFO - Return code: 0 20:42:31 INFO - Running post-action listener: _resource_record_post_action 20:42:31 INFO - Running post-action listener: _start_resource_monitoring 20:42:31 INFO - Starting resource monitoring. 20:42:31 INFO - [mozharness: 2016-12-09 04:42:31.967306Z] Finished create-virtualenv step (success) 20:42:31 INFO - [mozharness: 2016-12-09 04:42:31.967846Z] Running install step. 20:42:31 INFO - Running pre-action listener: _resource_record_pre_action 20:42:31 INFO - Running main action method: install 20:42:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:42:32 INFO - Reading from file tmpfile_stdout 20:42:32 INFO - Detecting whether we're running mozinstall >=1.0... 20:42:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:42:32 INFO - Reading from file tmpfile_stdout 20:42:32 INFO - Output received: 20:42:32 INFO - Usage: mozinstall [options] installer 20:42:32 INFO - Options: 20:42:32 INFO - -h, --help show this help message and exit 20:42:32 INFO - -d DEST, --destination=DEST 20:42:32 INFO - Directory to install application into. [default: 20:42:32 INFO - "/builds/slave/test"] 20:42:32 INFO - --app=APP Application being installed. [default: firefox] 20:42:32 INFO - mkdir: /builds/slave/test/build/application 20:42:32 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'] 20:42:32 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 20:42:49 INFO - Reading from file tmpfile_stdout 20:42:49 INFO - Output received: 20:42:49 INFO - /builds/slave/test/build/application/firefox/firefox 20:42:49 INFO - Running post-action listener: _resource_record_post_action 20:42:49 INFO - [mozharness: 2016-12-09 04:42:49.245068Z] Finished install step (success) 20:42:49 INFO - [mozharness: 2016-12-09 04:42:49.245340Z] Running run-tests step. 20:42:49 INFO - Running pre-action listener: _resource_record_pre_action 20:42:49 INFO - Running main action method: run_tests 20:42:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:42:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:42:49 INFO - Python 2.7.3 20:42:49 INFO - Return code: 0 20:42:49 INFO - grabbing minidump binary from tooltool 20:42:49 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')]} 20:42:49 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 0x174ef20>, '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 0x16bbc20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bbf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:42:49 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 20:42:49 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 20:42:49 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 20:42:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:42:49 INFO - Return code: 0 20:42:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:42:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:42:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:42:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:42:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:42:49 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/1481250982/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 20:42:49 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/1481250982/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 20:42:49 INFO - Using env: {'DISPLAY': ':0', 20:42:49 INFO - 'HOME': '/home/cltbld', 20:42:49 INFO - 'LANG': 'en_US.UTF-8', 20:42:49 INFO - 'LANGUAGE': 'en_US:en', 20:42:49 INFO - 'LOGNAME': 'cltbld', 20:42:49 INFO - 'MAIL': '/var/mail/cltbld', 20:42:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:42:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:49 INFO - 'MOZ_NO_REMOTE': '1', 20:42:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:42:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:49 INFO - 'NO_EM_RESTART': '1', 20:42:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:42:49 INFO - 'PWD': '/builds/slave/test', 20:42:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:42:49 INFO - 'SHELL': '/bin/bash', 20:42:49 INFO - 'SHLVL': '1', 20:42:49 INFO - 'TERM': 'linux', 20:42:49 INFO - 'TMOUT': '86400', 20:42:49 INFO - 'USER': 'cltbld', 20:42:49 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1481258501.324272-915262330', 20:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:49 INFO - '_': '/tools/buildbot/bin/python'} 20:42:49 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/1481250982/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 20:42:49 INFO - mozversion application_buildid: 20161208183622 20:42:49 INFO - mozversion application_changeset: b57b890350b0e607b4d9b4ca266a761d20fae15e 20:42:49 INFO - mozversion application_display_name: Nightly 20:42:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:42:49 INFO - mozversion application_name: Firefox 20:42:49 INFO - mozversion application_remotingname: firefox 20:42:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:42:49 INFO - mozversion application_vendor: Mozilla 20:42:49 INFO - mozversion application_version: 53.0a1 20:42:49 INFO - mozversion platform_buildid: 20161208183622 20:42:49 INFO - mozversion platform_changeset: b57b890350b0e607b4d9b4ca266a761d20fae15e 20:42:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:42:49 INFO - mozversion platform_version: 53.0a1 20:42:49 INFO - using testdate: 1481258569 20:42:49 INFO - actual date: 1481258569 20:42:49 INFO - starting webserver on 'localhost:45738' 20:42:49 INFO - SUITE-START | Running 2 tests 20:42:49 INFO - TEST-START | dromaeo_css 20:42:49 INFO - operating with platform_type : linux_ 20:42:49 INFO - Initialising browser for dromaeo_css test... 20:42:49 INFO - TEST-INFO | started process 18173 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuBe4cU/profile http://localhost:45738/getInfo.html) 20:42:53 INFO - PROCESS | 18173 | __metrics Screen width/height:1600/1200 20:42:53 INFO - PROCESS | 18173 | colorDepth:24 20:42:53 INFO - PROCESS | 18173 | Browser inner width/height: 1024/697 20:42:53 INFO - PROCESS | 18173 | __metrics 20:42:54 INFO - PROCESS | 18173 | 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" 20:42:54 INFO - PROCESS | 18173 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:42:54 INFO - PROCESS | 18173 | console.error: PushService: 20:42:54 INFO - PROCESS | 18173 | stateChangeProcessEnqueue: Error transitioning state 20:42:54 INFO - PROCESS | 18173 | UnknownError 20:42:55 INFO - TEST-INFO | 18173: exit 0 20:42:55 INFO - Browser initialized. 20:42:55 INFO - Running cycle 1/1 for dromaeo_css test... 20:42:55 INFO - TEST-INFO | started process 18256 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuBe4cU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:43:07 INFO - PROCESS | 18256 | RSS: Main: 172199936 20:43:07 INFO - PROCESS | 18256 | 20:43:59 INFO - PROCESS | 18256 | 1481258639023 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:46:09 INFO - PROCESS | 18256 | Cycle 1(1): loaded http://localhost:45738/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45738/tests/dromaeo/cssquery-ext.html) 20:46:11 INFO - PROCESS | 18256 | RSS: Main: 347734016 20:46:11 INFO - PROCESS | 18256 | 20:49:14 INFO - PROCESS | 18256 | Cycle 1(1): loaded http://localhost:45738/tests/dromaeo/cssquery-ext.html (next: http://localhost:45738/tests/dromaeo/cssquery-jquery.html) 20:49:15 INFO - PROCESS | 18256 | RSS: Main: 282570752 20:49:15 INFO - PROCESS | 18256 | 20:52:17 INFO - PROCESS | 18256 | Cycle 1(1): loaded http://localhost:45738/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45738/tests/dromaeo/cssquery-mootools.html) 20:52:17 INFO - PROCESS | 18256 | RSS: Main: 221044736 20:52:17 INFO - PROCESS | 18256 | 20:55:19 INFO - PROCESS | 18256 | Cycle 1(1): loaded http://localhost:45738/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45738/tests/dromaeo/cssquery-prototype.html) 20:55:20 INFO - PROCESS | 18256 | RSS: Main: 220295168 20:55:20 INFO - PROCESS | 18256 | 20:58:23 INFO - PROCESS | 18256 | Cycle 1(1): loaded http://localhost:45738/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45738/tests/dromaeo/cssquery-yui.html) 20:58:24 INFO - PROCESS | 18256 | RSS: Main: 221691904 20:58:24 INFO - PROCESS | 18256 | 21:01:26 INFO - PROCESS | 18256 | Cycle 1(1): loaded http://localhost:45738/tests/dromaeo/cssquery-yui.html (next: http://localhost:45738/tests/dromaeo/cssquery-dojo.html) 21:01:27 INFO - PROCESS | 18256 | RSS: Main: 320901120 21:01:27 INFO - PROCESS | 18256 | 21:01:27 INFO - PROCESS | 18256 | __start_tp_report 21:01:27 INFO - PROCESS | 18256 | _x_x_mozilla_page_load 21:01:27 INFO - PROCESS | 18256 | _x_x_mozilla_page_load_details 21:01:27 INFO - PROCESS | 18256 | |i|pagename|runs| 21:01:27 INFO - PROCESS | 18256 | |0;dojo.html;3201.3437245364703;3209.438348289049;3221.3557288542297;3275.5905511811025;3283.786553873998;5156.1234590119675;5192.195209742486;5231.2153177023465;5234.947650523493;5287.709175995319;5241.213817927303;5288.206768984654;5302.655327403716;5327.2808170896915;5363.839084827452;4740.620750339982;4753.714777113384;4779.498152693952;4793.616510679138;4825.662203645747;4883.731394773286;4900.8039678413;4926.45808961014;4940.555350018498;4977.576905962997;4727.290906364038;4752.310914917318;4814.855554333376;4855.660103792736;4871.123197824426;4786.066716990188;4797.160496913027;4805.111054454937;4814.590759785422;4820.493848145929;4770.403699537558;4779.354787103766;4782.306565547976;4783.617310615143;4795.712257264575;5174.042802081627;5193.143131383317;5209.1665333546825;5212.244224587452;5223.947760522384;5526.088195447746;5533.584981126432;5548.722563871831;5597.3003374578175;5621.325440947072;5581.944180558183;5594.9720251398485;5601.103823388279;5603.467670571289;5608.214849921014;5176.50823171798;5224.138017227153;5225.242339860737;5230.189320655267;5237.135872581058;5514.5864060195645;5604.971975140098;5668.121441176624;5668.263125793703;5685.090385538294;5609.298837645294;5610.214569960209;5612.438756124355;5614.466625670637;5620.409856965041;5615.241942337732;5628.915566266509;5630.0991841305195;5630.690312032878;5638.85902852432;5586.469285417878;5595.440455954372;5596.608237423341;5602.52378547828;5605.439456054443;5423.322084739408;5457.918131228034;5465.098258787256;5525.696086715269;5529.225908372831;4300.591443812833;4303.63419109373;4314.697971142053;4319.805608747551;4339.067100573392;3914.941275880864;3917.9804100979313;3949.328614135604;3951.644352008333;3966.424868394067;5269.55208807248;5298.549623281987;5314.468553144732;5317.30874986257;5368.516833485005;5529.419410961871;5608.439156084359;5625.46558076982;5628.6622802631155;5646.661200327993;5316.601254905898;5337.439568845293;5366.141417373202;5388.380336261302;5395.947790180956;4934.8026078957155;4942.283368911488;4943.505649435027;4944.060628480577;4993.550580447704;5589.55283577321;5692.459216374438;5767.22142510764;5780.826575202751;5791.507721843606;5620.578456615688;5638.182463542681;5638.774449021993;5650.124230744241;5722.713864306851;5736.913946290892;5790.4209579043445;5797.362290148165;5801.419858014334;5806.216160818235;5329.973350133225;5558.638688485235;5563.415841336601;5564.888702225851;5565.693886836263;5418.566514678895;5553.278073850373;5562.082256427644;5587.74855131512;5659.603827732019;5422.593305502024;5427.511523962862;5432.538234250133;5496.917546236729;5506.311711036121;5475.75359108849;5482.972585137049;5483.122700367922;5484.753186106715;5489.231507588861;5369.838904832861;5429.592780541396;5437.700926449083;5465.59008074388;5467.343918729778;5488.204210389551;5522.22688823573;5534.114541673474;5539.8892022160135;5551.833444996657;5328.040952628564;5401.513863752281;5415.458454154553;5418.83743487696;5457.69982650958 21:01:27 INFO - PROCESS | 18256 | |1;ext.html;557.3284192547983;560.3807792389409;580.590683568084;586.5454272938473;596.0493013643237;31004.53493197604;31674.683253167463;38875.61124388755;40055.59944400555;40213.396799047965;41513.7924310378;41692.79153604235;41965;42074;42077.78961105198;8272.338212942965;8464.534450605213;8465.238128568428;8465.280451161658;8465.873011904827;7490.101187857437;7828.373730101606;9873.555689993931;10176.949115254414;10180.64367747129;9983.75040623983;10048.899511004905;10050.944650811669;10053.346532475402;10054.74863128424;9955.203583713286;10024.498775061254;10033.448160351178;10037.34757240777;10044.397336159855;9928.156106730936;9990.850137247948;9993.650222242259;9996.70009899697;10002;39274;39569.60430395688;39707.8014609928;39731.20537589232;39736.40395394072;3087.8919237826794;3138.4507711150686;3215.244417561871;3423.246885685145;3428.160100775301;29701.108966730815;29901.850490747624;30235;30287;30531;4057.533383660858;4145.523264824554;4311.525732169459;4311.956880431218;4316.266234740102;287142;287740;289124;289686;289747;53744;54081.72959135258;54151.18773218405;54211.45788542143;54219.45780542223;56223.43776562182;56309.43690563042;56353.43646563482;56470.152947705814;56723;14182.219977901108;14338.283085845665;14364.353604087632;14426.495072672406;14428.278586070655;9388.90611093894;9621.326507144573;10933.398663073449;11029.889701103048;11051.613193538187;14038.859611403755;14201.644958876112;14218.360173792204;14962.551123466314;15492.845071549365;5392.193615138894;5587.580931430159;5682.7782026864425;5785.566082543742;5799.884002320015;895.3687650206589;994.7413672445216;1005.3063386263455;1040.427764729396;1050.8896565860628;30115.698843011727;30410.391792164475;30687.386252274828;30764.38471230563;31104.066877993697;1006.4615430744662;1041.4896700616644;1045.8849526552074;1048.570086264628;1074.5540600650643;15223.695526089416;15867.127307998171;15886.205689715467;15893.841061589235;16198.838011619968;431242;435069;436597;437156;438298;48696.7565162179;49627.25559116616;52225.60533565306;53210.733946330794;53750.731246343516;1252.843394575678;1258.2827788160844;1279.4347333596081;1280.8206851041048;1290.7547565962436;29034.419311613226;30229.546556801226;30728.539071913492;31076.22309442282;31165;46593.3011004842;47185.52814471811;47217.291740624605;47248;47308.52691473179;388492;390405;391172;391563;391568;37731.81134094312;37880.810595946845;38233;38358.424623631225;38909.80545097256;42971.3554296692;44193.33709994288;44365.77817111023;44527;44700;37124.44313335356;37597.06007349729;37632.43551346787;37681;38120.428193577674;36505.817470913535;37554.436683449225;37599;37984.43023354707;38733.41899871448;37110.44334334933;37485;38334;38474.61525384822;38496.61503385042;31166.22084447907;33577.72427926221;34035.48946765751;34107.14732131716;34177.87331900235;26226;26326.473470530098;26342.20973370802;26475;26913.865430672722 21:01:27 INFO - PROCESS | 18256 | |2;jquery.html;361.82270687363166;382.25460352312996;386.9090763670538;396.274817084735;417.640828887157;13105.81465425067;14754.409823607057;15908.920455397722;18652.62694746104;18792;18532.722009169873;19010.144543495542;19035.524111897208;19174.137163827625;19831.405057848253;5224.791008359661;6077.453029227379;6378.776742814002;6455.967720161392;6468.870622587546;6342.0803983422375;6342.682865856712;6375.489960803125;6388.233411990567;6396.936030639704;6160.7535698572;6258.405451482102;6344.809655710313;6387.169667943184;6393;6289.87420251597;6315.526335524854;6367.204099487564;6369.8089057328125;6370.331115232903;5872.324682661506;6081.452669259744;6162.383761623847;6167.198264225667;6196.411340922605;23639;23760.643590346157;23849.880750596138;23996.64005039926;24172.03311867523;2108.2726459371493;2236.418531181904;2352.6000579901456;2356.8468049576722;2485.453200295932;14612.561623151323;14791.55625331231;14974.935151263755;15269.923650381788;15346.386144554204;1985.7914918933593;2069.5860827834495;2074.2325339624285;2112.36629011296;2163.7836216378396;80902.59548702219;86456.17736029302;87933;88351;88528.11471885264;16186.19069046543;16438.342466301216;16500.812195426715;16688.6662266754;16957.236924338435;28766.568501472495;28824.711752882202;28912.421751564852;28938.85530572376;29043.85478072596;8792.692255771017;8850.628152636351;9074.36661400941;9128.90871091294;9336.533173341306;7270.309320614533;7292.817679558054;7367.152777430557;7531.171571127172;7552.093748750075;8278;8390.580470976427;8460.830783384297;8499.113010019264;8560.657573696983;3238.417084924736;3395.5043043363107;3467.5492186016163;3485.337785820686;3491.790492570454;829.8921140251849;951.6383774165772;1006.0312068888312;1032.200044965158;1059.1526778577108;17936.461906142835;18421.63156736858;18518;18620;18867.05664716759;889.7419748272928;926.6756635177769;935.0882889183129;936.9250459963187;959.0840747086515;9558.617655293849;10321.690349289533;10364.429956352322;10422.114120299708;10448.886463965051;407125;410043;413609;414821;416397;59553.70223148856;83356;84639.5768021156;85993.57003214944;86333.56833215794;947.1381043250609;968.1577027985556;983.9570055740937;984.1831280037552;985.605757696927;15364.615884602974;16634.918730282494;17068.14659267007;17245.22396492136;17338.393156239472;36276.55372739691;36393;38492.61507385002;39614.22700411059;40069.1986160281;49774.502254976986;51904.221436677726;53268;53901.46098539121;54615.45384546104;7689.88465173034;7730.652120654471;7744.380449564134;7796.766097017098;7903.996481337055;10187.388756674623;12283.447244874182;12473.251604903735;12504;12680.556180533637;10374.533146008598;10555.419451930218;10698.786024279627;10861.67414977552;10961.890381096406;10532.526036328536;10655.413952232702;11053.668389948314;11106.666799996014;11405.828912566152;10615.946920265349;11058.22592418523;11208.607698730506;11209.88790112121;11506.194566380273;7564.432667550066;7718.343940764873;7871.881921771293;8074.959625201836;8298.0042394913;10332.431716255678;10753.13974881992;10877.891221087688;10955.83566246491;11083.113350931744 21:01:27 INFO - PROCESS | 18256 | |3;mootools.html;1278.635588857176;1361.836579610447;1366.6378409721422;1471.57324375931;1675.3214947946085;7282.453815963804;7923.326517246034;8147.103818579959;8161.755147345574;8364.37267204959;8136.837263254732;8204.09754926959;8221.260086592205;8227.136150704164;8236.217559331853;1867.738516607676;1930.1121484117323;2121.7666056733747;2148.892555372233;2157.2880949286778;2120.978790212101;2181.1275489804125;2183.301343570058;2201.8458707890454;2206.8675879447283;2086.906089225981;2097.265956915075;2111.3876975677113;2115.365390382879;2148.581026699794;2193.166596693254;2209.7569267380577;2222.344408399526;2225.1766846266983;2226.4322597737473;2153.1710291537715;2182.6289530779804;2188.7592364839857;2190.9342719718434;2193.0131440851683;8285.50286982777;8357.122502137248;8438.156184381574;8515.53164575948;8517.36119791018;4662.160811054009;4773.379460670126;4776.785044672998;4780.306855505932;4783.712977221343;3168.66728993457;3232.935341293161;3381.7463690223085;3387.6442973487674;3388.491726241059;1029.8815636201857;1104.7072525780675;1136.7158210447387;1141.954321827126;1155.8266260060975;10916.290441121302;11213.719657008558;11237.719057023558;11440.313581185155;11522.942385288105;4177.185448837447;4282.914341713148;4378.715383500063;4393.890152746207;4394.231009573312;9204.95397523008;9209.079092090737;9210.76973075665;9211.217046551119;9227.861582076273;5053.84838454847;5055.443901170868;5058.418281897555;5063.11395505785;5064.417591976896;3950.7827069511454;3995.7202995790017;4610.377599024156;4729.881752956204;4733.219018861849;3561.6972557332915;3622.0582648511577;3668.3030224257304;3678.393065144221;3712.535933008374;1092.579356947581;1093.5079214353573;1105.7456784939347;1106.5338426584808;1113.1873732175395;812.622130709223;844.594594594598;851.3805164843392;862.7627402464373;870.2559311788457;4790.616750659939;5057.140286151363;5219.269302297681;5254.080535906278;5419.9090399599545;908.3096846396786;913.0413066280379;919.5540163020929;925.3013974449248;945.2343601682521;3357.244619960489;3412.1640198151117;3420.9144771380916;3498.632643572439;3515.5455199623043;9811.215102791759;10218.795624087477;10248.231382646181;10251.58993640246;10256.28206025586;9570.282228832866;10009.299349045497;10164.542595583216;10172.13536849376;10187.7453063674;7637.350825179811;7831;7857.685692572233;7865.370770338359;7955.562444065632;5018.874528136826;5164.612654051037;5244.187150991603;5277.498637629419;5291.550218231493;8943.329250306122;9051.411658242194;9236.07639236071;9317.86023209639;9325.906740932774;8967.192952634294;9157;9189.402688825205;9350.812983740423;9484.762880928032;6660.533762636763;6882.483813714091;6885.070515480346;7368.59472729005;7553.848923021619;7482.663280152297;7563.773086807405;7791.610419479117;7970.2826745593175;8021.318187954089;7212.206657267801;7358.264173582599;7467.850642987219;7546.622668866645;7559.433042521943;6815.795526134224;6956.304369563003;7016.19313778922;7063.964680176567;7161.820954476179;6493.058506516623;6613.14029176204;6617.470602351897;6618.63597502142;6619.437347825488;4565.885852853705;4599.379083823641;4679.3916790816975;4716.245400735866;4740.928886066781;4499.550044995605;4505.234110201208;4594.379758732528;4680.531946805292;4804.375431193923 21:01:27 INFO - PROCESS | 18256 | |4;prototype.html;366.78543052314393;367.63971308118033;372.78192257529344;375.58122693197095;379.53317419573904;5084.771185296661;5086.92369614456;5208.6874787512725;5215.556677682397;5254.2169637860725;5058.013687330972;5070.822521211759;5120.795168193277;5152;5166.276721259017;3925.627065428794;4046.312126938413;4178.415021896937;4202.747835129887;4221.134667393192;4058;4153.210889930903;4158.771267580282;4161.500619925613;4165.541790403053;4106.876793696194;4122.979739927444;4134.0854697438235;4135.66914646829;4136.710430269883;4107.54816970133;4129.545749967501;4130.943102104421;4133.9793301033305;4144.52337981133;3404.4042292598697;3552.5914519830294;3569.714422846192;3575.945096196602;3589.425691889285;5004.449510553836;5012.172991456406;5028.421731500887;5029.881473486462;5032.84901452957;4603.9079218415445;4610.792514336863;4614.162290191508;4614.3770590970125;4615.699979501322;5205.427402985669;5331.840044798623;5363.275957745733;5386.1920711893135;5412.3505179378335;3876.7206821748755;3880.1463677990796;3883.8058097095313;3893.260280546687;3895.020309463263;5523;5576.804811831566;5591.776328946838;5644.008675402043;5675.858103547362;3898.4152377143087;3987.282289187916;4003.159336539359;4006.639402453793;4012.1775036117524;4018.216447792652;4029.3351596986167;4029.959700403017;4033.415154802537;4043.2722110020477;4620.19146649335;4622.422197225347;4627.722336659811;4635.976820115878;4657.231556793159;5241.24002019705;5436.401995780461;5474.096774032319;5476.315460567429;5483.890322193533;1353.6074538383955;1359.6125104345215;1359.8436179839248;1360.8772762471;1377.4283672276094;892.8705337725993;931.3527098666361;933.5658918602883;940.2618944128826;948.8766460360109;5062.291279220912;5076.340075790124;5102.617303702237;5106.693598384109;5136.33069252487;5398.082326004589;5406.567474602022;5407.621466497308;5422.180466157576;5439.646422982493;5006.424261209934;5102.902875881703;5105.2086926526445;5118.283440318359;5259.973700131552;2895.8407287599384;2910.941781164407;2919.6934321895897;2925.502664547032;2928.546075358323;5597.80407685729;5621.409751976065;5632.97183514088;5643.830685079372;5663.575231857627;5433.483819037185;5565.805196818092;5681.204631351614;5742.827715168468;5772.5670574707065;5744.080947048536;5793.15999180125;5799.362070172362;5800.5939584229545;5804.622699524517;5540.722963851711;5655.377908429987;5660.377358490645;5668.008098582649;5675.545956323402;5584.385717570983;5606.887862242814;5611.859703507445;5619.297587801525;5622.1566764983945;5695.515881150149;5733.655980641175;5737.709015471485;5800.593958423039;5804.65172089676;3761.598929252726;3786.413105968579;3816.751911125768;3919.2553414851086;3959.7822119783687;5566.105625075019;5592.356878958809;5601.915971260353;5602.831915042555;5628.212050313042;5313.362396512443;5455.509004189484;5458.888433592972;5502.504774570308;5532.585056120887;5429.782808687608;5454.672719636835;5462.8361149165585;5464.726763661722;5480;5427;5465.754041068241;5471.686795169051;5477.712737506603;5514.80698175562;5225.712585807817;5349.358077030781;5414.35027796667;5493.890122197614;5529.391766905556;5264.447233040629;5299.867503312448;5309.840704778863;5316.680999140064;5317.867053323543 21:01:27 INFO - PROCESS | 18256 | |5;yui.html;648.9870202595948;674.3930462583675;704.1163340008288;714.7355478472966;720.4488566246821;14129.78805317921;15282.923585382057;15341.693166136685;15352;15373.69252614947;13379.464821407131;14585.489507867227;14790.926045369759;14793.260336983161;15070.664047072694;777.5684495105214;785.5090568394753;790.0677200902933;790.7943934577023;794.527256282511;787.9913710450604;791.5092642561591;791.6081539637887;791.778302075417;791.7941335252847;822.1408627983741;825.694493037577;826.9007719073719;827.7433995461427;831.0110967948152;824.9917500825035;826.2398593294183;826.7230477789948;826.8470332988386;826.8594338962391;604.9758009679607;607.2379164149008;607.9422454866825;608.3186830749589;608.3308360803081;13657.180569165881;13899.444022239199;14115.505957291445;14241.287935603283;14255.215963122024;12205.694857628541;12368.690782730413;12754.298513581749;12887.420066097047;12892.419841107172;10433.061024507755;10532.210084243712;10538.051575358179;10842.566297348096;10986.121110311156;3541.787492750443;3602.6397360264027;3627.4558816177782;3701.574318953301;3767.453719210699;72630.41131731987;74861.25138748597;77073;77906.61046694787;78629.60685196538;9219.585118669676;9277.350585459088;9330.673426430178;9392;9635.181009614122;19689.803101969082;19767.505812354808;19875.403737887886;19908.800911990984;20119.0946407412;7839.764807055797;7951.284384405316;8133.1866813319375;8261.463004904663;8461.280791132822;4178.603032711888;4345.847895323712;4410.779461026936;4420.668449866273;4505.07645932583;3163.636181839072;3234.094453553009;3269.1990462336403;3454.378211921828;3479.8434070466888;574.4600075928697;580.1587697838152;588.9882202355928;597.9714890388525;612.6140531465148;593.9703014849326;642.8328634554956;659.9373059559334;679.2881937517428;692.4425837201102;7798.25916537928;8626.698065567674;8762.255208307237;8804.691835785718;8949.955250223707;566.6118708684564;621.2110619513193;626.3454689849119;679.78926532775;687.6306100109504;3871.4680559145504;4148.730332528376;4188.392683060939;4204.726692764961;4224.4508213931995;65087;70084.29915700879;75519.24480755231;75822;77923;66874.33125668779;68729;69028.65485672539;69689.65155174294;72245.27754722386;60570.394296056475;60701;60829;61400.38599614036;63089;7638.427117966064;8338.624761885609;8368.372372072241;8594.441361311494;8905;41598.79200604099;43341.3498797512;44313.11373772571;45251.75971844489;45780.54219457896;56362;57213;58187.70906145442;59001.70499147477;59181;11087;11196.94401527987;11614.941925290319;12012.399380031138;12080.275183489019;12187.207831490925;12344.814827777771;12934.547290845152;12956.870431295567;13163.276019818619;11557.133215009077;12372.13395062337;12450;12504.499820007462;12601.873981260436;11618.593349232737;11665;11768.470418831002;11874.584389546324;11875.406229688308;11253.66239012831;11560.537578496765;11636.12729045308;11654.941725291319;12435.626931192079;9906.900930990887;9943.651972180938;9954.452505111998;10003.499825008867;10111.292209545261;9737.659181928599;9962.551685174329;10176.389416635026;10253;10261.538230779484 21:01:27 INFO - PROCESS | 18256 | __end_tp_report 21:01:27 INFO - PROCESS | 18256 | __start_cc_report 21:01:27 INFO - PROCESS | 18256 | _x_x_mozilla_cycle_collect,1873 21:01:27 INFO - PROCESS | 18256 | __end_cc_report 21:01:27 INFO - PROCESS | 18256 | __startTimestamp1481259687040__endTimestamp 21:01:27 INFO - PROCESS | 18256 | 21:01:27 INFO - PROCESS | 18256 | ------- Summary: start ------- 21:01:27 INFO - PROCESS | 18256 | Number of tests: 6 21:01:27 INFO - PROCESS | 18256 | 21:01:27 INFO - PROCESS | 18256 | [#0] dojo.html Cycles:165 Average:5224.99 Median:5422.59 stddev:544.78 (10.0%) stddev-sans-first:522.81 21:01:27 INFO - PROCESS | 18256 | Values: 3201.3 3209.4 3221.4 3275.6 3283.8 5156.1 5192.2 5231.2 5234.9 5287.7 5241.2 5288.2 5302.7 5327.3 5363.8 4740.6 4753.7 4779.5 4793.6 4825.7 4883.7 4900.8 4926.5 4940.6 4977.6 4727.3 4752.3 4814.9 4855.7 4871.1 4786.1 4797.2 4805.1 4814.6 4820.5 4770.4 4779.4 4782.3 4783.6 4795.7 5174.0 5193.1 5209.2 5212.2 5223.9 5526.1 5533.6 5548.7 5597.3 5621.3 5581.9 5595.0 5601.1 5603.5 5608.2 5176.5 5224.1 5225.2 5230.2 5237.1 5514.6 5605.0 5668.1 5668.3 5685.1 5609.3 5610.2 5612.4 5614.5 5620.4 5615.2 5628.9 5630.1 5630.7 5638.9 5586.5 5595.4 5596.6 5602.5 5605.4 5423.3 5457.9 5465.1 5525.7 5529.2 4300.6 4303.6 4314.7 4319.8 4339.1 3914.9 3918.0 3949.3 3951.6 3966.4 5269.6 5298.5 5314.5 5317.3 5368.5 5529.4 5608.4 5625.5 5628.7 5646.7 5316.6 5337.4 5366.1 5388.4 5395.9 4934.8 4942.3 4943.5 4944.1 4993.6 5589.6 5692.5 5767.2 5780.8 5791.5 5620.6 5638.2 5638.8 5650.1 5722.7 5736.9 5790.4 5797.4 5801.4 5806.2 5330.0 5558.6 5563.4 5564.9 5565.7 5418.6 5553.3 5562.1 5587.7 5659.6 5422.6 5427.5 5432.5 5496.9 5506.3 5475.8 5483.0 5483.1 5484.8 5489.2 5369.8 5429.6 5437.7 5465.6 5467.3 5488.2 5522.2 5534.1 5539.9 5551.8 5328.0 5401.5 5415.5 5418.8 5457.7 21:01:27 INFO - PROCESS | 18256 | 21:01:27 INFO - PROCESS | 18256 | [#1] ext.html Cycles:180 Average:53011.68 Median:38052.43 stddev:99413.65 (261.3%) stddev-sans-first:99614.52 21:01:27 INFO - PROCESS | 18256 | Values: 557.3 560.4 580.6 586.5 596.0 31004.5 31674.7 38875.6 40055.6 40213.4 41513.8 41692.8 41965.0 42074.0 42077.8 8272.3 8464.5 8465.2 8465.3 8465.9 7490.1 7828.4 9873.6 10176.9 10180.6 9983.8 10048.9 10050.9 10053.3 10054.7 9955.2 10024.5 10033.4 10037.3 10044.4 9928.2 9990.9 9993.7 9996.7 10002.0 39274.0 39569.6 39707.8 39731.2 39736.4 3087.9 3138.5 3215.2 3423.2 3428.2 29701.1 29901.9 30235.0 30287.0 30531.0 4057.5 4145.5 4311.5 4312.0 4316.3 287142.0 287740.0 289124.0 289686.0 289747.0 53744.0 54081.7 54151.2 54211.5 54219.5 56223.4 56309.4 56353.4 56470.2 56723.0 14182.2 14338.3 14364.4 14426.5 14428.3 9388.9 9621.3 10933.4 11029.9 11051.6 14038.9 14201.6 14218.4 14962.6 15492.8 5392.2 5587.6 5682.8 5785.6 5799.9 895.4 994.7 1005.3 1040.4 1050.9 30115.7 30410.4 30687.4 30764.4 31104.1 1006.5 1041.5 1045.9 1048.6 1074.6 15223.7 15867.1 15886.2 15893.8 16198.8 431242.0 435069.0 436597.0 437156.0 438298.0 48696.8 49627.3 52225.6 53210.7 53750.7 1252.8 1258.3 1279.4 1280.8 1290.8 29034.4 30229.5 30728.5 31076.2 31165.0 46593.3 47185.5 47217.3 47248.0 47308.5 388492.0 390405.0 391172.0 391563.0 391568.0 37731.8 37880.8 38233.0 38358.4 38909.8 42971.4 44193.3 44365.8 44527.0 44700.0 37124.4 37597.1 37632.4 37681.0 38120.4 36505.8 37554.4 37599.0 37984.4 38733.4 37110.4 37485.0 38334.0 38474.6 38496.6 31166.2 33577.7 34035.5 34107.1 34177.9 26226.0 26326.5 26342.2 26475.0 26913.9 21:01:27 INFO - PROCESS | 18256 | 21:01:27 INFO - PROCESS | 18256 | [#2] jquery.html Cycles:180 Average:27034.55 Median:19437.43 stddev:68182.41 (350.8%) stddev-sans-first:68344.27 21:01:27 INFO - PROCESS | 18256 | Values: 361.8 382.3 386.9 396.3 417.6 13105.8 14754.4 15908.9 18652.6 18792.0 18532.7 19010.1 19035.5 19174.1 19831.4 5224.8 6077.5 6378.8 6456.0 6468.9 6342.1 6342.7 6375.5 6388.2 6396.9 6160.8 6258.4 6344.8 6387.2 6393.0 6289.9 6315.5 6367.2 6369.8 6370.3 5872.3 6081.5 6162.4 6167.2 6196.4 23639.0 23760.6 23849.9 23996.6 24172.0 2108.3 2236.4 2352.6 2356.8 2485.5 14612.6 14791.6 14974.9 15269.9 15346.4 1985.8 2069.6 2074.2 2112.4 2163.8 80902.6 86456.2 87933.0 88351.0 88528.1 16186.2 16438.3 16500.8 16688.7 16957.2 28766.6 28824.7 28912.4 28938.9 29043.9 8792.7 8850.6 9074.4 9128.9 9336.5 7270.3 7292.8 7367.2 7531.2 7552.1 8278.0 8390.6 8460.8 8499.1 8560.7 3238.4 3395.5 3467.5 3485.3 3491.8 829.9 951.6 1006.0 1032.2 1059.2 17936.5 18421.6 18518.0 18620.0 18867.1 889.7 926.7 935.1 936.9 959.1 9558.6 10321.7 10364.4 10422.1 10448.9 407125.0 410043.0 413609.0 414821.0 416397.0 59553.7 83356.0 84639.6 85993.6 86333.6 947.1 968.2 984.0 984.2 985.6 15364.6 16634.9 17068.1 17245.2 17338.4 36276.6 36393.0 38492.6 39614.2 40069.2 49774.5 51904.2 53268.0 53901.5 54615.5 7689.9 7730.7 7744.4 7796.8 7904.0 10187.4 12283.4 12473.3 12504.0 12680.6 10374.5 10555.4 10698.8 10861.7 10961.9 10532.5 10655.4 11053.7 11106.7 11405.8 10615.9 11058.2 11208.6 11209.9 11506.2 7564.4 7718.3 7871.9 8075.0 8298.0 10332.4 10753.1 10877.9 10955.8 11083.1 21:01:27 INFO - PROCESS | 18256 | 21:01:27 INFO - PROCESS | 18256 | [#3] mootools.html Cycles:180 Average:5335.42 Median:4782.01 stddev:3036.31 (63.5%) stddev-sans-first:3029.52 21:01:27 INFO - PROCESS | 18256 | Values: 1278.6 1361.8 1366.6 1471.6 1675.3 7282.5 7923.3 8147.1 8161.8 8364.4 8136.8 8204.1 8221.3 8227.1 8236.2 1867.7 1930.1 2121.8 2148.9 2157.3 2121.0 2181.1 2183.3 2201.8 2206.9 2086.9 2097.3 2111.4 2115.4 2148.6 2193.2 2209.8 2222.3 2225.2 2226.4 2153.2 2182.6 2188.8 2190.9 2193.0 8285.5 8357.1 8438.2 8515.5 8517.4 4662.2 4773.4 4776.8 4780.3 4783.7 3168.7 3232.9 3381.7 3387.6 3388.5 1029.9 1104.7 1136.7 1142.0 1155.8 10916.3 11213.7 11237.7 11440.3 11522.9 4177.2 4282.9 4378.7 4393.9 4394.2 9205.0 9209.1 9210.8 9211.2 9227.9 5053.8 5055.4 5058.4 5063.1 5064.4 3950.8 3995.7 4610.4 4729.9 4733.2 3561.7 3622.1 3668.3 3678.4 3712.5 1092.6 1093.5 1105.7 1106.5 1113.2 812.6 844.6 851.4 862.8 870.3 4790.6 5057.1 5219.3 5254.1 5419.9 908.3 913.0 919.6 925.3 945.2 3357.2 3412.2 3420.9 3498.6 3515.5 9811.2 10218.8 10248.2 10251.6 10256.3 9570.3 10009.3 10164.5 10172.1 10187.7 7637.4 7831.0 7857.7 7865.4 7955.6 5018.9 5164.6 5244.2 5277.5 5291.6 8943.3 9051.4 9236.1 9317.9 9325.9 8967.2 9157.0 9189.4 9350.8 9484.8 6660.5 6882.5 6885.1 7368.6 7553.8 7482.7 7563.8 7791.6 7970.3 8021.3 7212.2 7358.3 7467.9 7546.6 7559.4 6815.8 6956.3 7016.2 7064.0 7161.8 6493.1 6613.1 6617.5 6618.6 6619.4 4565.9 4599.4 4679.4 4716.2 4740.9 4499.6 4505.2 4594.4 4680.5 4804.4 21:01:27 INFO - PROCESS | 18256 | 21:01:27 INFO - PROCESS | 18256 | [#4] prototype.html Cycles:180 Average:4574.13 Median:5185.85 stddev:1337.68 (25.8%) stddev-sans-first:1303.63 21:01:27 INFO - PROCESS | 18256 | Values: 366.8 367.6 372.8 375.6 379.5 5084.8 5086.9 5208.7 5215.6 5254.2 5058.0 5070.8 5120.8 5152.0 5166.3 3925.6 4046.3 4178.4 4202.7 4221.1 4058.0 4153.2 4158.8 4161.5 4165.5 4106.9 4123.0 4134.1 4135.7 4136.7 4107.5 4129.5 4130.9 4134.0 4144.5 3404.4 3552.6 3569.7 3575.9 3589.4 5004.4 5012.2 5028.4 5029.9 5032.8 4603.9 4610.8 4614.2 4614.4 4615.7 5205.4 5331.8 5363.3 5386.2 5412.4 3876.7 3880.1 3883.8 3893.3 3895.0 5523.0 5576.8 5591.8 5644.0 5675.9 3898.4 3987.3 4003.2 4006.6 4012.2 4018.2 4029.3 4030.0 4033.4 4043.3 4620.2 4622.4 4627.7 4636.0 4657.2 5241.2 5436.4 5474.1 5476.3 5483.9 1353.6 1359.6 1359.8 1360.9 1377.4 892.9 931.4 933.6 940.3 948.9 5062.3 5076.3 5102.6 5106.7 5136.3 5398.1 5406.6 5407.6 5422.2 5439.6 5006.4 5102.9 5105.2 5118.3 5260.0 2895.8 2910.9 2919.7 2925.5 2928.5 5597.8 5621.4 5633.0 5643.8 5663.6 5433.5 5565.8 5681.2 5742.8 5772.6 5744.1 5793.2 5799.4 5800.6 5804.6 5540.7 5655.4 5660.4 5668.0 5675.5 5584.4 5606.9 5611.9 5619.3 5622.2 5695.5 5733.7 5737.7 5800.6 5804.7 3761.6 3786.4 3816.8 3919.3 3959.8 5566.1 5592.4 5601.9 5602.8 5628.2 5313.4 5455.5 5458.9 5502.5 5532.6 5429.8 5454.7 5462.8 5464.7 5480.0 5427.0 5465.8 5471.7 5477.7 5514.8 5225.7 5349.4 5414.4 5493.9 5529.4 5264.4 5299.9 5309.8 5316.7 5317.9 21:01:27 INFO - PROCESS | 18256 | 21:01:27 INFO - PROCESS | 18256 | [#5] yui.html Cycles:180 Average:16807.79 Median:29388.35 stddev:22075.65 (75.1%) stddev-sans-first:22104.23 21:01:27 INFO - PROCESS | 18256 | Values: 649.0 674.4 704.1 714.7 720.4 14129.8 15282.9 15341.7 15352.0 15373.7 13379.5 14585.5 14790.9 14793.3 15070.7 777.6 785.5 790.1 790.8 794.5 788.0 791.5 791.6 791.8 791.8 822.1 825.7 826.9 827.7 831.0 825.0 826.2 826.7 826.8 826.9 605.0 607.2 607.9 608.3 608.3 13657.2 13899.4 14115.5 14241.3 14255.2 12205.7 12368.7 12754.3 12887.4 12892.4 10433.1 10532.2 10538.1 10842.6 10986.1 3541.8 3602.6 3627.5 3701.6 3767.5 72630.4 74861.3 77073.0 77906.6 78629.6 9219.6 9277.4 9330.7 9392.0 9635.2 19689.8 19767.5 19875.4 19908.8 20119.1 7839.8 7951.3 8133.2 8261.5 8461.3 4178.6 4345.8 4410.8 4420.7 4505.1 3163.6 3234.1 3269.2 3454.4 3479.8 574.5 580.2 589.0 598.0 612.6 594.0 642.8 659.9 679.3 692.4 7798.3 8626.7 8762.3 8804.7 8950.0 566.6 621.2 626.3 679.8 687.6 3871.5 4148.7 4188.4 4204.7 4224.5 65087.0 70084.3 75519.2 75822.0 77923.0 66874.3 68729.0 69028.7 69689.7 72245.3 60570.4 60701.0 60829.0 61400.4 63089.0 7638.4 8338.6 8368.4 8594.4 8905.0 41598.8 43341.3 44313.1 45251.8 45780.5 56362.0 57213.0 58187.7 59001.7 59181.0 11087.0 11196.9 11614.9 12012.4 12080.3 12187.2 12344.8 12934.5 12956.9 13163.3 11557.1 12372.1 12450.0 12504.5 12601.9 11618.6 11665.0 11768.5 11874.6 11875.4 11253.7 11560.5 11636.1 11654.9 12435.6 9906.9 9943.7 9954.5 10003.5 10111.3 9737.7 9962.6 10176.4 10253.0 10261.5 21:01:27 INFO - PROCESS | 18256 | -------- Summary: end -------- 21:01:27 INFO - PROCESS | 18256 | 21:01:27 INFO - TEST-INFO | 18256: exit 0 21:01:28 INFO - TEST-OK | dromaeo_css | took 1118479ms 21:01:28 INFO - TEST-START | kraken 21:01:28 INFO - operating with platform_type : linux_ 21:01:28 INFO - Initialising browser for kraken test... 21:01:28 INFO - TEST-INFO | started process 18558 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp35uxCI/profile http://localhost:45738/getInfo.html) 21:01:32 INFO - PROCESS | 18558 | __metrics Screen width/height:1600/1200 21:01:32 INFO - PROCESS | 18558 | colorDepth:24 21:01:32 INFO - PROCESS | 18558 | Browser inner width/height: 1024/697 21:01:32 INFO - PROCESS | 18558 | __metrics 21:01:32 INFO - PROCESS | 18558 | 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" 21:01:32 INFO - PROCESS | 18558 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:01:33 INFO - PROCESS | 18558 | console.error: PushService: 21:01:33 INFO - PROCESS | 18558 | stateChangeProcessEnqueue: Error transitioning state 21:01:33 INFO - PROCESS | 18558 | UnknownError 21:01:33 INFO - TEST-INFO | 18558: exit 0 21:01:33 INFO - Browser initialized. 21:01:33 INFO - Running cycle 1/1 for kraken test... 21:01:33 INFO - TEST-INFO | started process 18640 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp35uxCI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:01:46 INFO - PROCESS | 18640 | RSS: Main: 172105728 21:01:46 INFO - PROCESS | 18640 | 21:01:48 INFO - PROCESS | 18640 | Cycle 1(1): loaded http://localhost:45738/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45738/tests/kraken/driver.html?testName=audio-beat-detection) 21:01:49 INFO - PROCESS | 18640 | RSS: Main: 229892096 21:01:49 INFO - PROCESS | 18640 | 21:01:52 INFO - PROCESS | 18640 | Cycle 1(1): loaded http://localhost:45738/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45738/tests/kraken/driver.html?testName=audio-dft) 21:01:52 INFO - PROCESS | 18640 | RSS: Main: 216694784 21:01:52 INFO - PROCESS | 18640 | 21:01:55 INFO - PROCESS | 18640 | Cycle 1(1): loaded http://localhost:45738/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45738/tests/kraken/driver.html?testName=audio-fft) 21:01:56 INFO - PROCESS | 18640 | RSS: Main: 298110976 21:01:56 INFO - PROCESS | 18640 | 21:01:58 INFO - PROCESS | 18640 | Cycle 1(1): loaded http://localhost:45738/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45738/tests/kraken/driver.html?testName=audio-oscillator) 21:01:58 INFO - PROCESS | 18640 | RSS: Main: 208052224 21:01:58 INFO - PROCESS | 18640 | 21:02:01 INFO - PROCESS | 18640 | Cycle 1(1): loaded http://localhost:45738/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45738/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:02:01 INFO - PROCESS | 18640 | RSS: Main: 213667840 21:02:01 INFO - PROCESS | 18640 | 21:02:04 INFO - PROCESS | 18640 | Cycle 1(1): loaded http://localhost:45738/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45738/tests/kraken/driver.html?testName=imaging-darkroom) 21:02:05 INFO - PROCESS | 18640 | RSS: Main: 252751872 21:02:05 INFO - PROCESS | 18640 | 21:02:09 INFO - PROCESS | 18640 | Cycle 1(1): loaded http://localhost:45738/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45738/tests/kraken/driver.html?testName=imaging-desaturate) 21:02:09 INFO - PROCESS | 18640 | RSS: Main: 247115776 21:02:09 INFO - PROCESS | 18640 | 21:02:12 INFO - PROCESS | 18640 | Cycle 1(1): loaded http://localhost:45738/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45738/tests/kraken/driver.html?testName=json-parse-financial) 21:02:13 INFO - PROCESS | 18640 | RSS: Main: 249999360 21:02:13 INFO - PROCESS | 18640 | 21:02:14 INFO - PROCESS | 18640 | Cycle 1(1): loaded http://localhost:45738/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45738/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:02:15 INFO - PROCESS | 18640 | RSS: Main: 211951616 21:02:15 INFO - PROCESS | 18640 | 21:02:17 INFO - PROCESS | 18640 | Cycle 1(1): loaded http://localhost:45738/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45738/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:02:17 INFO - PROCESS | 18640 | RSS: Main: 218656768 21:02:17 INFO - PROCESS | 18640 | 21:02:20 INFO - PROCESS | 18640 | Cycle 1(1): loaded http://localhost:45738/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45738/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:02:20 INFO - PROCESS | 18640 | RSS: Main: 223703040 21:02:20 INFO - PROCESS | 18640 | 21:02:23 INFO - PROCESS | 18640 | Cycle 1(1): loaded http://localhost:45738/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45738/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:02:23 INFO - PROCESS | 18640 | RSS: Main: 222556160 21:02:23 INFO - PROCESS | 18640 | 21:02:26 INFO - PROCESS | 18640 | Cycle 1(1): loaded http://localhost:45738/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45738/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:02:27 INFO - PROCESS | 18640 | RSS: Main: 225615872 21:02:27 INFO - PROCESS | 18640 | 21:02:29 INFO - PROCESS | 18640 | Cycle 1(1): loaded http://localhost:45738/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45738/tests/kraken/driver.html?testName=ai-astar) 21:02:29 INFO - PROCESS | 18640 | RSS: Main: 278257664 21:02:29 INFO - PROCESS | 18640 | 21:02:29 INFO - PROCESS | 18640 | __start_tp_report 21:02:29 INFO - PROCESS | 18640 | _x_x_mozilla_page_load 21:02:29 INFO - PROCESS | 18640 | _x_x_mozilla_page_load_details 21:02:29 INFO - PROCESS | 18640 | |i|pagename|runs| 21:02:29 INFO - PROCESS | 18640 | |0;ai-astar;110;112;113;112;111;111;112;111;110;110 21:02:29 INFO - PROCESS | 18640 | |1;audio-beat-detection;152;122;128;163;130;123;122;129;143;128 21:02:29 INFO - PROCESS | 18640 | |2;audio-dft;163;162;161;160;160;163;162;159;160;160 21:02:29 INFO - PROCESS | 18640 | |3;audio-fft;76;76;74;99;77;76;75;76;91;78 21:02:29 INFO - PROCESS | 18640 | |4;audio-oscillator;85;84;104;84;84;84;94;84;85;104 21:02:29 INFO - PROCESS | 18640 | |5;imaging-gaussian-blur;128;128;128;127;128;128;128;128;127;129 21:02:29 INFO - PROCESS | 18640 | |6;imaging-darkroom;194;188;187;187;189;190;190;187;188;189 21:02:29 INFO - PROCESS | 18640 | |7;imaging-desaturate;95;95;96;96;97;96;97;96;96;96 21:02:29 INFO - PROCESS | 18640 | |8;json-parse-financial;55;52;53;53;53;53;54;53;55;53 21:02:29 INFO - PROCESS | 18640 | |9;json-stringify-tinderbox;63;64;64;63;65;66;66;64;64;65 21:02:29 INFO - PROCESS | 18640 | |10;stanford-crypto-aes;86;85;84;84;84;88;93;88;116;85 21:02:29 INFO - PROCESS | 18640 | |11;stanford-crypto-ccm;139;150;130;137;131;131;130;136;159;130 21:02:29 INFO - PROCESS | 18640 | |12;stanford-crypto-pbkdf2;179;179;167;166;171;164;166;171;167;167 21:02:29 INFO - PROCESS | 18640 | |13;stanford-crypto-sha256-iterative;66;65;64;65;63;64;63;62;63;63 21:02:29 INFO - PROCESS | 18640 | __end_tp_report 21:02:29 INFO - PROCESS | 18640 | __start_cc_report 21:02:29 INFO - PROCESS | 18640 | _x_x_mozilla_cycle_collect,1639 21:02:29 INFO - PROCESS | 18640 | __end_cc_report 21:02:29 INFO - PROCESS | 18640 | __startTimestamp1481259749314__endTimestamp 21:02:29 INFO - PROCESS | 18640 | 21:02:29 INFO - PROCESS | 18640 | ------- Summary: start ------- 21:02:29 INFO - PROCESS | 18640 | Number of tests: 14 21:02:29 INFO - PROCESS | 18640 | 21:02:29 INFO - PROCESS | 18640 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.50 stddev:1.03 (0.9%) stddev-sans-first:1.00 21:02:29 INFO - PROCESS | 18640 | Values: 110.0 112.0 113.0 112.0 111.0 111.0 112.0 111.0 110.0 110.0 21:02:29 INFO - PROCESS | 18640 | 21:02:29 INFO - PROCESS | 18640 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:129.50 stddev:14.02 (10.8%) stddev-sans-first:13.27 21:02:29 INFO - PROCESS | 18640 | Values: 152.0 122.0 128.0 163.0 130.0 123.0 122.0 129.0 143.0 128.0 21:02:29 INFO - PROCESS | 18640 | 21:02:29 INFO - PROCESS | 18640 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.41 (0.9%) stddev-sans-first:1.30 21:02:29 INFO - PROCESS | 18640 | Values: 163.0 162.0 161.0 160.0 160.0 163.0 162.0 159.0 160.0 160.0 21:02:29 INFO - PROCESS | 18640 | 21:02:29 INFO - PROCESS | 18640 | [#3] audio-fft Cycles:10 Average:79.80 Median:76.50 stddev:8.30 (10.8%) stddev-sans-first:8.69 21:02:29 INFO - PROCESS | 18640 | Values: 76.0 76.0 74.0 99.0 77.0 76.0 75.0 76.0 91.0 78.0 21:02:29 INFO - PROCESS | 18640 | 21:02:29 INFO - PROCESS | 18640 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:84.00 stddev:8.38 (10.0%) stddev-sans-first:8.75 21:02:29 INFO - PROCESS | 18640 | Values: 85.0 84.0 104.0 84.0 84.0 84.0 94.0 84.0 85.0 104.0 21:02:29 INFO - PROCESS | 18640 | 21:02:29 INFO - PROCESS | 18640 | [#5] imaging-gaussian-blur Cycles:10 Average:127.90 Median:128.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 21:02:29 INFO - PROCESS | 18640 | Values: 128.0 128.0 128.0 127.0 128.0 128.0 128.0 128.0 127.0 129.0 21:02:29 INFO - PROCESS | 18640 | 21:02:29 INFO - PROCESS | 18640 | [#6] imaging-darkroom Cycles:10 Average:188.90 Median:189.00 stddev:2.13 (1.1%) stddev-sans-first:1.22 21:02:29 INFO - PROCESS | 18640 | Values: 194.0 188.0 187.0 187.0 189.0 190.0 190.0 187.0 188.0 189.0 21:02:29 INFO - PROCESS | 18640 | 21:02:29 INFO - PROCESS | 18640 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 21:02:29 INFO - PROCESS | 18640 | Values: 95.0 95.0 96.0 96.0 97.0 96.0 97.0 96.0 96.0 96.0 21:02:29 INFO - PROCESS | 18640 | 21:02:29 INFO - PROCESS | 18640 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.00 stddev:0.97 (1.8%) stddev-sans-first:0.83 21:02:29 INFO - PROCESS | 18640 | Values: 55.0 52.0 53.0 53.0 53.0 53.0 54.0 53.0 55.0 53.0 21:02:29 INFO - PROCESS | 18640 | 21:02:29 INFO - PROCESS | 18640 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:1.07 (1.7%) stddev-sans-first:1.01 21:02:29 INFO - PROCESS | 18640 | Values: 63.0 64.0 64.0 63.0 65.0 66.0 66.0 64.0 64.0 65.0 21:02:29 INFO - PROCESS | 18640 | 21:02:29 INFO - PROCESS | 18640 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:85.50 stddev:9.79 (11.4%) stddev-sans-first:10.31 21:02:29 INFO - PROCESS | 18640 | Values: 86.0 85.0 84.0 84.0 84.0 88.0 93.0 88.0 116.0 85.0 21:02:29 INFO - PROCESS | 18640 | 21:02:29 INFO - PROCESS | 18640 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:136.50 stddev:9.87 (7.2%) stddev-sans-first:10.45 21:02:29 INFO - PROCESS | 18640 | Values: 139.0 150.0 130.0 137.0 131.0 131.0 130.0 136.0 159.0 130.0 21:02:29 INFO - PROCESS | 18640 | 21:02:29 INFO - PROCESS | 18640 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.70 Median:169.00 stddev:5.36 (3.2%) stddev-sans-first:4.50 21:02:29 INFO - PROCESS | 18640 | Values: 179.0 179.0 167.0 166.0 171.0 164.0 166.0 171.0 167.0 167.0 21:02:29 INFO - PROCESS | 18640 | 21:02:29 INFO - PROCESS | 18640 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:1.23 (1.9%) stddev-sans-first:1.01 21:02:29 INFO - PROCESS | 18640 | Values: 66.0 65.0 64.0 65.0 63.0 64.0 63.0 62.0 63.0 63.0 21:02:29 INFO - PROCESS | 18640 | -------- Summary: end -------- 21:02:29 INFO - PROCESS | 18640 | 21:02:30 INFO - TEST-INFO | 18640: exit 0 21:02:30 INFO - TEST-OK | kraken | took 62556ms 21:02:30 INFO - SUITE-END | took 1181s 21:02:30 INFO - Completed test suite (00:19:41) 21:02:30 INFO - javascript benchmark 21:02:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3201.3437245364703, 3209.438348289049, 3221.3557288542297, 3275.5905511811025, 3283.786553873998, 5156.1234590119675, 5192.195209742486, 5231.2153177023465, 5234.947650523493, 5287.709175995319, 5241.213817927303, 5288.206768984654, 5302.655327403716, 5327.2808170896915, 5363.839084827452, 4740.620750339982, 4753.714777113384, 4779.498152693952, 4793.616510679138, 4825.662203645747, 4883.731394773286, 4900.8039678413, 4926.45808961014, 4940.555350018498, 4977.576905962997, 4727.290906364038, 4752.310914917318, 4814.855554333376, 4855.660103792736, 4871.123197824426, 4786.066716990188, 4797.160496913027, 4805.111054454937, 4814.590759785422, 4820.493848145929, 4770.403699537558, 4779.354787103766, 4782.306565547976, 4783.617310615143, 4795.712257264575, 5174.042802081627, 5193.143131383317, 5209.1665333546825, 5212.244224587452, 5223.947760522384, 5526.088195447746, 5533.584981126432, 5548.722563871831, 5597.3003374578175, 5621.325440947072, 5581.944180558183, 5594.9720251398485, 5601.103823388279, 5603.467670571289, 5608.214849921014, 5176.50823171798, 5224.138017227153, 5225.242339860737, 5230.189320655267, 5237.135872581058, 5514.5864060195645, 5604.971975140098, 5668.121441176624, 5668.263125793703, 5685.090385538294, 5609.298837645294, 5610.214569960209, 5612.438756124355, 5614.466625670637, 5620.409856965041, 5615.241942337732, 5628.915566266509, 5630.0991841305195, 5630.690312032878, 5638.85902852432, 5586.469285417878, 5595.440455954372, 5596.608237423341, 5602.52378547828, 5605.439456054443, 5423.322084739408, 5457.918131228034, 5465.098258787256, 5525.696086715269, 5529.225908372831, 4300.591443812833, 4303.63419109373, 4314.697971142053, 4319.805608747551, 4339.067100573392, 3914.941275880864, 3917.9804100979313, 3949.328614135604, 3951.644352008333, 3966.424868394067, 5269.55208807248, 5298.549623281987, 5314.468553144732, 5317.30874986257, 5368.516833485005, 5529.419410961871, 5608.439156084359, 5625.46558076982, 5628.6622802631155, 5646.661200327993, 5316.601254905898, 5337.439568845293, 5366.141417373202, 5388.380336261302, 5395.947790180956, 4934.8026078957155, 4942.283368911488, 4943.505649435027, 4944.060628480577, 4993.550580447704, 5589.55283577321, 5692.459216374438, 5767.22142510764, 5780.826575202751, 5791.507721843606, 5620.578456615688, 5638.182463542681, 5638.774449021993, 5650.124230744241, 5722.713864306851, 5736.913946290892, 5790.4209579043445, 5797.362290148165, 5801.419858014334, 5806.216160818235, 5329.973350133225, 5558.638688485235, 5563.415841336601, 5564.888702225851, 5565.693886836263, 5418.566514678895, 5553.278073850373, 5562.082256427644, 5587.74855131512, 5659.603827732019, 5422.593305502024, 5427.511523962862, 5432.538234250133, 5496.917546236729, 5506.311711036121, 5475.75359108849, 5482.972585137049, 5483.122700367922, 5484.753186106715, 5489.231507588861, 5369.838904832861, 5429.592780541396, 5437.700926449083, 5465.59008074388, 5467.343918729778, 5488.204210389551, 5522.22688823573, 5534.114541673474, 5539.8892022160135, 5551.833444996657, 5328.040952628564, 5401.513863752281, 5415.458454154553, 5418.83743487696, 5457.69982650958], "value": 5191.807880752958, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.3284192547983, 560.3807792389409, 580.590683568084, 586.5454272938473, 596.0493013643237, 31004.53493197604, 31674.683253167463, 38875.61124388755, 40055.59944400555, 40213.396799047965, 41513.7924310378, 41692.79153604235, 41965.0, 42074.0, 42077.78961105198, 8272.338212942965, 8464.534450605213, 8465.238128568428, 8465.280451161658, 8465.873011904827, 7490.101187857437, 7828.373730101606, 9873.555689993931, 10176.949115254414, 10180.64367747129, 9983.75040623983, 10048.899511004905, 10050.944650811669, 10053.346532475402, 10054.74863128424, 9955.203583713286, 10024.498775061254, 10033.448160351178, 10037.34757240777, 10044.397336159855, 9928.156106730936, 9990.850137247948, 9993.650222242259, 9996.70009899697, 10002.0, 39274.0, 39569.60430395688, 39707.8014609928, 39731.20537589232, 39736.40395394072, 3087.8919237826794, 3138.4507711150686, 3215.244417561871, 3423.246885685145, 3428.160100775301, 29701.108966730815, 29901.850490747624, 30235.0, 30287.0, 30531.0, 4057.533383660858, 4145.523264824554, 4311.525732169459, 4311.956880431218, 4316.266234740102, 287142.0, 287740.0, 289124.0, 289686.0, 289747.0, 53744.0, 54081.72959135258, 54151.18773218405, 54211.45788542143, 54219.45780542223, 56223.43776562182, 56309.43690563042, 56353.43646563482, 56470.152947705814, 56723.0, 14182.219977901108, 14338.283085845665, 14364.353604087632, 14426.495072672406, 14428.278586070655, 9388.90611093894, 9621.326507144573, 10933.398663073449, 11029.889701103048, 11051.613193538187, 14038.859611403755, 14201.644958876112, 14218.360173792204, 14962.551123466314, 15492.845071549365, 5392.193615138894, 5587.580931430159, 5682.7782026864425, 5785.566082543742, 5799.884002320015, 895.3687650206589, 994.7413672445216, 1005.3063386263455, 1040.427764729396, 1050.8896565860628, 30115.698843011727, 30410.391792164475, 30687.386252274828, 30764.38471230563, 31104.066877993697, 1006.4615430744662, 1041.4896700616644, 1045.8849526552074, 1048.570086264628, 1074.5540600650643, 15223.695526089416, 15867.127307998171, 15886.205689715467, 15893.841061589235, 16198.838011619968, 431242.0, 435069.0, 436597.0, 437156.0, 438298.0, 48696.7565162179, 49627.25559116616, 52225.60533565306, 53210.733946330794, 53750.731246343516, 1252.843394575678, 1258.2827788160844, 1279.4347333596081, 1280.8206851041048, 1290.7547565962436, 29034.419311613226, 30229.546556801226, 30728.539071913492, 31076.22309442282, 31165.0, 46593.3011004842, 47185.52814471811, 47217.291740624605, 47248.0, 47308.52691473179, 388492.0, 390405.0, 391172.0, 391563.0, 391568.0, 37731.81134094312, 37880.810595946845, 38233.0, 38358.424623631225, 38909.80545097256, 42971.3554296692, 44193.33709994288, 44365.77817111023, 44527.0, 44700.0, 37124.44313335356, 37597.06007349729, 37632.43551346787, 37681.0, 38120.428193577674, 36505.817470913535, 37554.436683449225, 37599.0, 37984.43023354707, 38733.41899871448, 37110.44334334933, 37485.0, 38334.0, 38474.61525384822, 38496.61503385042, 31166.22084447907, 33577.72427926221, 34035.48946765751, 34107.14732131716, 34177.87331900235, 26226.0, 26326.473470530098, 26342.20973370802, 26475.0, 26913.865430672722], "value": 18829.17274827957, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.82270687363166, 382.25460352312996, 386.9090763670538, 396.274817084735, 417.640828887157, 13105.81465425067, 14754.409823607057, 15908.920455397722, 18652.62694746104, 18792.0, 18532.722009169873, 19010.144543495542, 19035.524111897208, 19174.137163827625, 19831.405057848253, 5224.791008359661, 6077.453029227379, 6378.776742814002, 6455.967720161392, 6468.870622587546, 6342.0803983422375, 6342.682865856712, 6375.489960803125, 6388.233411990567, 6396.936030639704, 6160.7535698572, 6258.405451482102, 6344.809655710313, 6387.169667943184, 6393.0, 6289.87420251597, 6315.526335524854, 6367.204099487564, 6369.8089057328125, 6370.331115232903, 5872.324682661506, 6081.452669259744, 6162.383761623847, 6167.198264225667, 6196.411340922605, 23639.0, 23760.643590346157, 23849.880750596138, 23996.64005039926, 24172.03311867523, 2108.2726459371493, 2236.418531181904, 2352.6000579901456, 2356.8468049576722, 2485.453200295932, 14612.561623151323, 14791.55625331231, 14974.935151263755, 15269.923650381788, 15346.386144554204, 1985.7914918933593, 2069.5860827834495, 2074.2325339624285, 2112.36629011296, 2163.7836216378396, 80902.59548702219, 86456.17736029302, 87933.0, 88351.0, 88528.11471885264, 16186.19069046543, 16438.342466301216, 16500.812195426715, 16688.6662266754, 16957.236924338435, 28766.568501472495, 28824.711752882202, 28912.421751564852, 28938.85530572376, 29043.85478072596, 8792.692255771017, 8850.628152636351, 9074.36661400941, 9128.90871091294, 9336.533173341306, 7270.309320614533, 7292.817679558054, 7367.152777430557, 7531.171571127172, 7552.093748750075, 8278.0, 8390.580470976427, 8460.830783384297, 8499.113010019264, 8560.657573696983, 3238.417084924736, 3395.5043043363107, 3467.5492186016163, 3485.337785820686, 3491.790492570454, 829.8921140251849, 951.6383774165772, 1006.0312068888312, 1032.200044965158, 1059.1526778577108, 17936.461906142835, 18421.63156736858, 18518.0, 18620.0, 18867.05664716759, 889.7419748272928, 926.6756635177769, 935.0882889183129, 936.9250459963187, 959.0840747086515, 9558.617655293849, 10321.690349289533, 10364.429956352322, 10422.114120299708, 10448.886463965051, 407125.0, 410043.0, 413609.0, 414821.0, 416397.0, 59553.70223148856, 83356.0, 84639.5768021156, 85993.57003214944, 86333.56833215794, 947.1381043250609, 968.1577027985556, 983.9570055740937, 984.1831280037552, 985.605757696927, 15364.615884602974, 16634.918730282494, 17068.14659267007, 17245.22396492136, 17338.393156239472, 36276.55372739691, 36393.0, 38492.61507385002, 39614.22700411059, 40069.1986160281, 49774.502254976986, 51904.221436677726, 53268.0, 53901.46098539121, 54615.45384546104, 7689.88465173034, 7730.652120654471, 7744.380449564134, 7796.766097017098, 7903.996481337055, 10187.388756674623, 12283.447244874182, 12473.251604903735, 12504.0, 12680.556180533637, 10374.533146008598, 10555.419451930218, 10698.786024279627, 10861.67414977552, 10961.890381096406, 10532.526036328536, 10655.413952232702, 11053.668389948314, 11106.666799996014, 11405.828912566152, 10615.946920265349, 11058.22592418523, 11208.607698730506, 11209.88790112121, 11506.194566380273, 7564.432667550066, 7718.343940764873, 7871.881921771293, 8074.959625201836, 8298.0042394913, 10332.431716255678, 10753.13974881992, 10877.891221087688, 10955.83566246491, 11083.113350931744], "value": 9675.302375416497, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1278.635588857176, 1361.836579610447, 1366.6378409721422, 1471.57324375931, 1675.3214947946085, 7282.453815963804, 7923.326517246034, 8147.103818579959, 8161.755147345574, 8364.37267204959, 8136.837263254732, 8204.09754926959, 8221.260086592205, 8227.136150704164, 8236.217559331853, 1867.738516607676, 1930.1121484117323, 2121.7666056733747, 2148.892555372233, 2157.2880949286778, 2120.978790212101, 2181.1275489804125, 2183.301343570058, 2201.8458707890454, 2206.8675879447283, 2086.906089225981, 2097.265956915075, 2111.3876975677113, 2115.365390382879, 2148.581026699794, 2193.166596693254, 2209.7569267380577, 2222.344408399526, 2225.1766846266983, 2226.4322597737473, 2153.1710291537715, 2182.6289530779804, 2188.7592364839857, 2190.9342719718434, 2193.0131440851683, 8285.50286982777, 8357.122502137248, 8438.156184381574, 8515.53164575948, 8517.36119791018, 4662.160811054009, 4773.379460670126, 4776.785044672998, 4780.306855505932, 4783.712977221343, 3168.66728993457, 3232.935341293161, 3381.7463690223085, 3387.6442973487674, 3388.491726241059, 1029.8815636201857, 1104.7072525780675, 1136.7158210447387, 1141.954321827126, 1155.8266260060975, 10916.290441121302, 11213.719657008558, 11237.719057023558, 11440.313581185155, 11522.942385288105, 4177.185448837447, 4282.914341713148, 4378.715383500063, 4393.890152746207, 4394.231009573312, 9204.95397523008, 9209.079092090737, 9210.76973075665, 9211.217046551119, 9227.861582076273, 5053.84838454847, 5055.443901170868, 5058.418281897555, 5063.11395505785, 5064.417591976896, 3950.7827069511454, 3995.7202995790017, 4610.377599024156, 4729.881752956204, 4733.219018861849, 3561.6972557332915, 3622.0582648511577, 3668.3030224257304, 3678.393065144221, 3712.535933008374, 1092.579356947581, 1093.5079214353573, 1105.7456784939347, 1106.5338426584808, 1113.1873732175395, 812.622130709223, 844.594594594598, 851.3805164843392, 862.7627402464373, 870.2559311788457, 4790.616750659939, 5057.140286151363, 5219.269302297681, 5254.080535906278, 5419.9090399599545, 908.3096846396786, 913.0413066280379, 919.5540163020929, 925.3013974449248, 945.2343601682521, 3357.244619960489, 3412.1640198151117, 3420.9144771380916, 3498.632643572439, 3515.5455199623043, 9811.215102791759, 10218.795624087477, 10248.231382646181, 10251.58993640246, 10256.28206025586, 9570.282228832866, 10009.299349045497, 10164.542595583216, 10172.13536849376, 10187.7453063674, 7637.350825179811, 7831.0, 7857.685692572233, 7865.370770338359, 7955.562444065632, 5018.874528136826, 5164.612654051037, 5244.187150991603, 5277.498637629419, 5291.550218231493, 8943.329250306122, 9051.411658242194, 9236.07639236071, 9317.86023209639, 9325.906740932774, 8967.192952634294, 9157.0, 9189.402688825205, 9350.812983740423, 9484.762880928032, 6660.533762636763, 6882.483813714091, 6885.070515480346, 7368.59472729005, 7553.848923021619, 7482.663280152297, 7563.773086807405, 7791.610419479117, 7970.2826745593175, 8021.318187954089, 7212.206657267801, 7358.264173582599, 7467.850642987219, 7546.622668866645, 7559.433042521943, 6815.795526134224, 6956.304369563003, 7016.19313778922, 7063.964680176567, 7161.820954476179, 6493.058506516623, 6613.14029176204, 6617.470602351897, 6618.63597502142, 6619.437347825488, 4565.885852853705, 4599.379083823641, 4679.3916790816975, 4716.245400735866, 4740.928886066781, 4499.550044995605, 4505.234110201208, 4594.379758732528, 4680.531946805292, 4804.375431193923], "value": 4271.036454313038, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.78543052314393, 367.63971308118033, 372.78192257529344, 375.58122693197095, 379.53317419573904, 5084.771185296661, 5086.92369614456, 5208.6874787512725, 5215.556677682397, 5254.2169637860725, 5058.013687330972, 5070.822521211759, 5120.795168193277, 5152.0, 5166.276721259017, 3925.627065428794, 4046.312126938413, 4178.415021896937, 4202.747835129887, 4221.134667393192, 4058.0, 4153.210889930903, 4158.771267580282, 4161.500619925613, 4165.541790403053, 4106.876793696194, 4122.979739927444, 4134.0854697438235, 4135.66914646829, 4136.710430269883, 4107.54816970133, 4129.545749967501, 4130.943102104421, 4133.9793301033305, 4144.52337981133, 3404.4042292598697, 3552.5914519830294, 3569.714422846192, 3575.945096196602, 3589.425691889285, 5004.449510553836, 5012.172991456406, 5028.421731500887, 5029.881473486462, 5032.84901452957, 4603.9079218415445, 4610.792514336863, 4614.162290191508, 4614.3770590970125, 4615.699979501322, 5205.427402985669, 5331.840044798623, 5363.275957745733, 5386.1920711893135, 5412.3505179378335, 3876.7206821748755, 3880.1463677990796, 3883.8058097095313, 3893.260280546687, 3895.020309463263, 5523.0, 5576.804811831566, 5591.776328946838, 5644.008675402043, 5675.858103547362, 3898.4152377143087, 3987.282289187916, 4003.159336539359, 4006.639402453793, 4012.1775036117524, 4018.216447792652, 4029.3351596986167, 4029.959700403017, 4033.415154802537, 4043.2722110020477, 4620.19146649335, 4622.422197225347, 4627.722336659811, 4635.976820115878, 4657.231556793159, 5241.24002019705, 5436.401995780461, 5474.096774032319, 5476.315460567429, 5483.890322193533, 1353.6074538383955, 1359.6125104345215, 1359.8436179839248, 1360.8772762471, 1377.4283672276094, 892.8705337725993, 931.3527098666361, 933.5658918602883, 940.2618944128826, 948.8766460360109, 5062.291279220912, 5076.340075790124, 5102.617303702237, 5106.693598384109, 5136.33069252487, 5398.082326004589, 5406.567474602022, 5407.621466497308, 5422.180466157576, 5439.646422982493, 5006.424261209934, 5102.902875881703, 5105.2086926526445, 5118.283440318359, 5259.973700131552, 2895.8407287599384, 2910.941781164407, 2919.6934321895897, 2925.502664547032, 2928.546075358323, 5597.80407685729, 5621.409751976065, 5632.97183514088, 5643.830685079372, 5663.575231857627, 5433.483819037185, 5565.805196818092, 5681.204631351614, 5742.827715168468, 5772.5670574707065, 5744.080947048536, 5793.15999180125, 5799.362070172362, 5800.5939584229545, 5804.622699524517, 5540.722963851711, 5655.377908429987, 5660.377358490645, 5668.008098582649, 5675.545956323402, 5584.385717570983, 5606.887862242814, 5611.859703507445, 5619.297587801525, 5622.1566764983945, 5695.515881150149, 5733.655980641175, 5737.709015471485, 5800.593958423039, 5804.65172089676, 3761.598929252726, 3786.413105968579, 3816.751911125768, 3919.2553414851086, 3959.7822119783687, 5566.105625075019, 5592.356878958809, 5601.915971260353, 5602.831915042555, 5628.212050313042, 5313.362396512443, 5455.509004189484, 5458.888433592972, 5502.504774570308, 5532.585056120887, 5429.782808687608, 5454.672719636835, 5462.8361149165585, 5464.726763661722, 5480.0, 5427.0, 5465.754041068241, 5471.686795169051, 5477.712737506603, 5514.80698175562, 5225.712585807817, 5349.358077030781, 5414.35027796667, 5493.890122197614, 5529.391766905556, 5264.447233040629, 5299.867503312448, 5309.840704778863, 5316.680999140064, 5317.867053323543], "value": 4159.566972287529, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.9870202595948, 674.3930462583675, 704.1163340008288, 714.7355478472966, 720.4488566246821, 14129.78805317921, 15282.923585382057, 15341.693166136685, 15352.0, 15373.69252614947, 13379.464821407131, 14585.489507867227, 14790.926045369759, 14793.260336983161, 15070.664047072694, 777.5684495105214, 785.5090568394753, 790.0677200902933, 790.7943934577023, 794.527256282511, 787.9913710450604, 791.5092642561591, 791.6081539637887, 791.778302075417, 791.7941335252847, 822.1408627983741, 825.694493037577, 826.9007719073719, 827.7433995461427, 831.0110967948152, 824.9917500825035, 826.2398593294183, 826.7230477789948, 826.8470332988386, 826.8594338962391, 604.9758009679607, 607.2379164149008, 607.9422454866825, 608.3186830749589, 608.3308360803081, 13657.180569165881, 13899.444022239199, 14115.505957291445, 14241.287935603283, 14255.215963122024, 12205.694857628541, 12368.690782730413, 12754.298513581749, 12887.420066097047, 12892.419841107172, 10433.061024507755, 10532.210084243712, 10538.051575358179, 10842.566297348096, 10986.121110311156, 3541.787492750443, 3602.6397360264027, 3627.4558816177782, 3701.574318953301, 3767.453719210699, 72630.41131731987, 74861.25138748597, 77073.0, 77906.61046694787, 78629.60685196538, 9219.585118669676, 9277.350585459088, 9330.673426430178, 9392.0, 9635.181009614122, 19689.803101969082, 19767.505812354808, 19875.403737887886, 19908.800911990984, 20119.0946407412, 7839.764807055797, 7951.284384405316, 8133.1866813319375, 8261.463004904663, 8461.280791132822, 4178.603032711888, 4345.847895323712, 4410.779461026936, 4420.668449866273, 4505.07645932583, 3163.636181839072, 3234.094453553009, 3269.1990462336403, 3454.378211921828, 3479.8434070466888, 574.4600075928697, 580.1587697838152, 588.9882202355928, 597.9714890388525, 612.6140531465148, 593.9703014849326, 642.8328634554956, 659.9373059559334, 679.2881937517428, 692.4425837201102, 7798.25916537928, 8626.698065567674, 8762.255208307237, 8804.691835785718, 8949.955250223707, 566.6118708684564, 621.2110619513193, 626.3454689849119, 679.78926532775, 687.6306100109504, 3871.4680559145504, 4148.730332528376, 4188.392683060939, 4204.726692764961, 4224.4508213931995, 65087.0, 70084.29915700879, 75519.24480755231, 75822.0, 77923.0, 66874.33125668779, 68729.0, 69028.65485672539, 69689.65155174294, 72245.27754722386, 60570.394296056475, 60701.0, 60829.0, 61400.38599614036, 63089.0, 7638.427117966064, 8338.624761885609, 8368.372372072241, 8594.441361311494, 8905.0, 41598.79200604099, 43341.3498797512, 44313.11373772571, 45251.75971844489, 45780.54219457896, 56362.0, 57213.0, 58187.70906145442, 59001.70499147477, 59181.0, 11087.0, 11196.94401527987, 11614.941925290319, 12012.399380031138, 12080.275183489019, 12187.207831490925, 12344.814827777771, 12934.547290845152, 12956.870431295567, 13163.276019818619, 11557.133215009077, 12372.13395062337, 12450.0, 12504.499820007462, 12601.873981260436, 11618.593349232737, 11665.0, 11768.470418831002, 11874.584389546324, 11875.406229688308, 11253.66239012831, 11560.537578496765, 11636.12729045308, 11654.941725291319, 12435.626931192079, 9906.900930990887, 9943.651972180938, 9954.452505111998, 10003.499825008867, 10111.292209545261, 9737.659181928599, 9962.551685174329, 10176.389416635026, 10253.0, 10261.538230779484], "value": 6735.819151893145, "unit": "score"}], "name": "dromaeo_css", "value": 6955.135895349541, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 113.0, 112.0, 111.0, 111.0, 112.0, 111.0, 110.0, 110.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 122.0, 128.0, 163.0, 130.0, 123.0, 122.0, 129.0, 143.0, 128.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 160.0, 160.0, 163.0, 162.0, 159.0, 160.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 99.0, 77.0, 76.0, 75.0, 76.0, 91.0, 78.0], "value": 79.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 104.0, 84.0, 84.0, 84.0, 94.0, 84.0, 85.0, 104.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 128.0, 128.0, 127.0, 128.0, 128.0, 128.0, 128.0, 127.0, 129.0], "value": 127.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 188.0, 187.0, 187.0, 189.0, 190.0, 190.0, 187.0, 188.0, 189.0], "value": 188.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 53.0, 53.0, 53.0, 53.0, 54.0, 53.0, 55.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 65.0, 66.0, 66.0, 64.0, 64.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 84.0, 84.0, 84.0, 88.0, 93.0, 88.0, 116.0, 85.0], "value": 89.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 150.0, 130.0, 137.0, 131.0, 131.0, 130.0, 136.0, 159.0, 130.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 179.0, 167.0, 166.0, 171.0, 164.0, 166.0, 171.0, 167.0, 167.0], "value": 169.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 65.0, 63.0, 64.0, 63.0, 62.0, 63.0, 63.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1565.9, "alertThreshold": 2.0}]} 21:02:31 INFO - Return code: 0 21:02:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:02:31 INFO - # TBPL SUCCESS # 21:02:31 INFO - Running post-action listener: _resource_record_post_action 21:02:31 INFO - [mozharness: 2016-12-09 05:02:31.141731Z] Finished run-tests step (success) 21:02:31 INFO - Running post-run listener: _resource_record_post_run 21:02:31 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393633792; Read time: 16; Write time: 203688 21:02:31 INFO - TinderboxPrint: CPU usage
13.2% 21:02:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 21:02:31 INFO - TinderboxPrint: I/O write bytes / time
393,633,792 / 203,688 21:02:31 INFO - TinderboxPrint: CPU idle
8,304.6 (86.8%) 21:02:31 INFO - TinderboxPrint: CPU user
1,210.3 (12.7%) 21:02:31 INFO - TinderboxPrint: Swap in / out
0 / 0 21:02:31 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 80932864; Read time: 0; Write time: 44808 21:02:31 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 289583104; Read time: 0; Write time: 155520 21:02:31 INFO - Running post-run listener: _upload_blobber_files 21:02:31 INFO - Blob upload gear active. 21:02:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:02:31 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 21:02:31 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'] 21:02:31 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 21:02:32 INFO - (blobuploader) - INFO - Open directory for files ... 21:02:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:02:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:02:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:02:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:02:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:02:33 INFO - (blobuploader) - INFO - Done attempting. 21:02:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:02:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:02:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:02:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:02:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:02:33 INFO - (blobuploader) - INFO - Done attempting. 21:02:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:02:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:02:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:02:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:02:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:02:38 INFO - (blobuploader) - INFO - Done attempting. 21:02:38 INFO - (blobuploader) - INFO - Iteration through files over. 21:02:38 INFO - Return code: 0 21:02:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:02:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:02:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9fe29388ca942253143468b8da8519f697cf6708c171435a7c8cbd147c95eb57ba7d41de1984b713d7fcbd6b299bce4709bef9e6b6090b6322006130511b4a32", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0232350787c712a6631b1c433b9d923ffae41245ef077cdedff06b9da4312092c03df954d011a2521458d5477de7a8cd164c2c58d075a5302d4543d9b672738a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aacf2130212268edb5dd7bf8696a95e395cff3e1b0d14cf44c1bd37faafffc24f95c8e475962d8f1bdb974f64953d8063a0e710c292a1601ad35d61a95623c25"} 21:02:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:02:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:02:38 INFO - Contents: 21:02:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9fe29388ca942253143468b8da8519f697cf6708c171435a7c8cbd147c95eb57ba7d41de1984b713d7fcbd6b299bce4709bef9e6b6090b6322006130511b4a32", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0232350787c712a6631b1c433b9d923ffae41245ef077cdedff06b9da4312092c03df954d011a2521458d5477de7a8cd164c2c58d075a5302d4543d9b672738a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aacf2130212268edb5dd7bf8696a95e395cff3e1b0d14cf44c1bd37faafffc24f95c8e475962d8f1bdb974f64953d8063a0e710c292a1601ad35d61a95623c25"} 21:02:38 INFO - Running post-run listener: copy_logs_to_upload_dir 21:02:38 INFO - Copying logs to upload dir... 21:02:38 INFO - mkdir: /builds/slave/test/build/upload/logs 21:02:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.423909 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-12-08 21:02:37.666102) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-08 21:02:37.669405) ========= 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=337fe3f4b1febe37b85fccc40000019e-1481258501.324272-915262330 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/9fe29388ca942253143468b8da8519f697cf6708c171435a7c8cbd147c95eb57ba7d41de1984b713d7fcbd6b299bce4709bef9e6b6090b6322006130511b4a32", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0232350787c712a6631b1c433b9d923ffae41245ef077cdedff06b9da4312092c03df954d011a2521458d5477de7a8cd164c2c58d075a5302d4543d9b672738a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aacf2130212268edb5dd7bf8696a95e395cff3e1b0d14cf44c1bd37faafffc24f95c8e475962d8f1bdb974f64953d8063a0e710c292a1601ad35d61a95623c25"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481250982/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011425 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1481250982/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/9fe29388ca942253143468b8da8519f697cf6708c171435a7c8cbd147c95eb57ba7d41de1984b713d7fcbd6b299bce4709bef9e6b6090b6322006130511b4a32", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0232350787c712a6631b1c433b9d923ffae41245ef077cdedff06b9da4312092c03df954d011a2521458d5477de7a8cd164c2c58d075a5302d4543d9b672738a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aacf2130212268edb5dd7bf8696a95e395cff3e1b0d14cf44c1bd37faafffc24f95c8e475962d8f1bdb974f64953d8063a0e710c292a1601ad35d61a95623c25"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-08 21:02:37.694328) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 21:02:37.694627) ========= 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=337fe3f4b1febe37b85fccc40000019e-1481258501.324272-915262330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-08 21:02:37.775518) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-08 21:02:37.775800) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-08 21:02:37.776072) ========= ========= Total master_lag: 0.16 =========