builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1484354609.06 results: success (0) buildid: 20170113164300 builduid: cf1af103715e4a5995384e935ed55411 revision: 4ef05cc6af4ec1ff02dc6ceb0e85c1ee3a3f9e86 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 16:43:29.061519) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 16:43:29.062123) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 16:43:29.062445) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 16:43:29.097180) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 16:43:29.097437) ========= 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-1484354049.71403-85007996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-13 16:43:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 32.1M=0s 2017-01-13 16:43:30 (32.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137035 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 16:43:29.247888) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 16:43:29.248185) ========= 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-1484354049.71403-85007996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019457 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 16:43:29.301433) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 16:43:29.301740) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4ef05cc6af4ec1ff02dc6ceb0e85c1ee3a3f9e86 --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 4ef05cc6af4ec1ff02dc6ceb0e85c1ee3a3f9e86 --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-1484354049.71403-85007996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-13 16:43:30,118 truncating revision to first 12 chars 2017-01-13 16:43:30,118 Setting DEBUG logging. 2017-01-13 16:43:30,118 attempt 1/10 2017-01-13 16:43:30,118 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/4ef05cc6af4e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-13 16:43:30,459 unpacking tar archive at: mozilla-inbound-4ef05cc6af4e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.652374 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 16:43:29.967224) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 16:43:29.967535) ========= script_repo_revision: 4ef05cc6af4ec1ff02dc6ceb0e85c1ee3a3f9e86 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 16:43:29.967943) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 16:43:29.968248) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 16:43:29.976607) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-13 16:43:29.976896) ========= /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-1484354049.71403-85007996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:43:30 INFO - MultiFileLogger online at 20170113 16:43:30 in /builds/slave/test 16:43:30 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 16:43:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:43:30 INFO - {'append_to_log': False, 16:43:30 INFO - 'base_work_dir': '/builds/slave/test', 16:43:30 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:43:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:43:30 INFO - 'branch': 'Mozilla-Inbound', 16:43:30 INFO - 'buildbot_json_path': 'buildprops.json', 16:43:30 INFO - 'config_files': ('talos/linux_config.py',), 16:43:30 INFO - 'default_actions': ('clobber', 16:43:30 INFO - 'read-buildbot-config', 16:43:30 INFO - 'download-and-extract', 16:43:30 INFO - 'populate-webroot', 16:43:30 INFO - 'create-virtualenv', 16:43:30 INFO - 'install', 16:43:30 INFO - 'run-tests'), 16:43:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:43:30 INFO - 'download_minidump_stackwalk': True, 16:43:30 INFO - 'download_symbols': 'ondemand', 16:43:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:43:30 INFO - 'tooltool.py': '/tools/tooltool.py', 16:43:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:43:30 INFO - '/tools/misc-python/virtualenv.py')}, 16:43:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:43:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:43:30 INFO - 'installer_path': 'installer.exe', 16:43:30 INFO - 'log_level': 'info', 16:43:30 INFO - 'log_name': 'talos', 16:43:30 INFO - 'log_to_console': True, 16:43:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:43:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:43:30 INFO - 'opt_config_files': (), 16:43:30 INFO - 'pip_index': False, 16:43:30 INFO - 'sps_profile': False, 16:43:30 INFO - 'sps_profile_interval': 0, 16:43:30 INFO - 'suite': 'dromaeojs', 16:43:30 INFO - 'system_bits': '32', 16:43:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:43:30 INFO - 'title': 'talos-linux64-ix-060', 16:43:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:43:30 INFO - 'use_talos_json': True, 16:43:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:43:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:43:30 INFO - 'work_dir': 'build'} 16:43:30 INFO - [mozharness: 2017-01-14 00:43:30.898390Z] Running clobber step. 16:43:30 INFO - Running pre-action listener: _resource_record_pre_action 16:43:30 INFO - Running main action method: clobber 16:43:30 INFO - rmtree: /builds/slave/test/build 16:43:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:43:31 INFO - Running post-action listener: _resource_record_post_action 16:43:31 INFO - [mozharness: 2017-01-14 00:43:31.361953Z] Finished clobber step (success) 16:43:31 INFO - [mozharness: 2017-01-14 00:43:31.362055Z] Running read-buildbot-config step. 16:43:31 INFO - Running pre-action listener: _resource_record_pre_action 16:43:31 INFO - Running main action method: read_buildbot_config 16:43:31 INFO - Using buildbot properties: 16:43:31 INFO - { 16:43:31 INFO - "project": "", 16:43:31 INFO - "product": "firefox", 16:43:31 INFO - "script_repo_revision": "production", 16:43:31 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 16:43:31 INFO - "repository": "", 16:43:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 16:43:31 INFO - "buildid": "20170113164300", 16:43:31 INFO - "stage_platform": "linux64-pgo", 16:43:31 INFO - "basedir": "/builds/slave/test", 16:43:31 INFO - "buildnumber": 2419, 16:43:31 INFO - "platform": "ubuntu64_hw", 16:43:31 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:43:31 INFO - "slavebuilddir": "test", 16:43:31 INFO - "branch": "mozilla-inbound", 16:43:31 INFO - "revision": "4ef05cc6af4ec1ff02dc6ceb0e85c1ee3a3f9e86", 16:43:31 INFO - "slavename": "talos-linux64-ix-060", 16:43:31 INFO - "builduid": "cf1af103715e4a5995384e935ed55411", 16:43:31 INFO - "repo_path": "integration/mozilla-inbound" 16:43:31 INFO - } 16:43:31 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484348225/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 16:43:31 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484348225/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 16:43:31 INFO - Running post-action listener: _resource_record_post_action 16:43:31 INFO - [mozharness: 2017-01-14 00:43:31.364518Z] Finished read-buildbot-config step (success) 16:43:31 INFO - [mozharness: 2017-01-14 00:43:31.364606Z] Running download-and-extract step. 16:43:31 INFO - Running pre-action listener: _resource_record_pre_action 16:43:31 INFO - Running main action method: download_and_extract 16:43:31 INFO - mkdir: /builds/slave/test/build/tests 16:43: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')]} 16:43:31 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484348225/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 16:43:31 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484348225/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 16:43:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484348225/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 16:43:31 INFO - Downloaded 1361 bytes. 16:43:31 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 16:43:31 INFO - Using the following test package requirements: 16:43:31 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 16:43:31 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:43:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:43:31 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:43:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:43:31 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:43:31 INFO - u'jsshell-linux-x86_64.zip'], 16:43:31 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:43:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:43:31 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 16:43:31 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:43:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:43:31 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:43:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:43:31 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:43:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:43:31 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 16:43:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:43:31 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:43:31 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/1484348225/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 16:43:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484348225/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:43:31 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484348225/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:43:31 INFO - Expected file size: 21859603 16:43:31 INFO - Obtained file size: 21859603 16:43:35 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 16:43:35 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/1484348225/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 16:43:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484348225/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:43:35 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484348225/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:43:35 INFO - Expected file size: 21859603 16:43:35 INFO - Obtained file size: 21859603 16:43:40 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/1484348225/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 16:43:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484348225/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:43:40 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484348225/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 16:43:40 INFO - Expected file size: 14403555 16:43:40 INFO - Obtained file size: 14403555 16:43:40 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')]} 16:43:40 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484348225/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 16:43:40 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484348225/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 16:43:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484348225/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 16:43:41 INFO - Downloaded 61661133 bytes. 16:43:41 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484348225/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 16:43:41 INFO - mkdir: /builds/slave/test/properties 16:43:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:43:41 INFO - Writing to file /builds/slave/test/properties/build_url 16:43:41 INFO - Contents: 16:43:41 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484348225/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 16:43:41 INFO - Running post-action listener: _resource_record_post_action 16:43:41 INFO - Running post-action listener: set_extra_try_arguments 16:43:41 INFO - [mozharness: 2017-01-14 00:43:41.975441Z] Finished download-and-extract step (success) 16:43:41 INFO - [mozharness: 2017-01-14 00:43:41.975572Z] Running populate-webroot step. 16:43:41 INFO - Running pre-action listener: _resource_record_pre_action 16:43:41 INFO - Running main action method: populate_webroot 16:43:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:43:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:43:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:43:41 INFO - '--tppagecycles', 16:43:41 INFO - '7'], 16:43:41 INFO - 'tests': ['tsvgm']}}, 16:43:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:43:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:43:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:43:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:43:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:43:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:43:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:43:41 INFO - 'talos_options': ['--disable-e10s'], 16:43:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:43:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:43:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:43:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:43:41 INFO - 'talos_options': ['--disable-e10s'], 16:43:41 INFO - 'tests': ['damp', 'tps']}, 16:43:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:43:41 INFO - 'tests': ['damp', 'tps']}, 16:43:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:43:41 INFO - 'tests': ['dromaeo_dom']}, 16:43:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:43:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:43:41 INFO - 'tests': ['basic_compositor_video']}, 16:43:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:43:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:43:41 INFO - 'tests': ['a11yr', 16:43:41 INFO - 'ts_paint', 16:43:41 INFO - 'tpaint', 16:43:41 INFO - 'sessionrestore', 16:43:41 INFO - 'sessionrestore_no_auto_restore', 16:43:41 INFO - 'tabpaint']}, 16:43:41 INFO - 'other-e10s': {'tests': ['a11yr', 16:43:41 INFO - 'ts_paint', 16:43:41 INFO - 'tpaint', 16:43:41 INFO - 'sessionrestore', 16:43:41 INFO - 'sessionrestore_no_auto_restore', 16:43:41 INFO - 'tabpaint']}, 16:43:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:43:41 INFO - 'ts_paint', 16:43:41 INFO - 'tpaint', 16:43:41 INFO - 'sessionrestore', 16:43:41 INFO - 'sessionrestore_no_auto_restore', 16:43:41 INFO - 'tabpaint']}, 16:43:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:43:41 INFO - 'ts_paint', 16:43:41 INFO - 'tpaint', 16:43:41 INFO - 'sessionrestore', 16:43:41 INFO - 'sessionrestore_no_auto_restore', 16:43:41 INFO - 'tabpaint']}, 16:43:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:43:41 INFO - 'tests': ['a11yr', 16:43:41 INFO - 'ts_paint', 16:43:41 INFO - 'tpaint', 16:43:41 INFO - 'sessionrestore', 16:43:41 INFO - 'sessionrestore_no_auto_restore', 16:43:41 INFO - 'tabpaint']}, 16:43:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:43:41 INFO - 'tests': ['a11yr', 16:43:41 INFO - 'ts_paint', 16:43:41 INFO - 'tpaint', 16:43:41 INFO - 'sessionrestore', 16:43:41 INFO - 'sessionrestore_no_auto_restore', 16:43:41 INFO - 'tabpaint']}, 16:43:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:43:41 INFO - 'tests': ['tsvgx', 16:43:41 INFO - 'tsvgr_opacity', 16:43:41 INFO - 'tart', 16:43:41 INFO - 'tscrollx', 16:43:41 INFO - 'cart', 16:43:41 INFO - 'tsvg_static']}, 16:43:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:43:41 INFO - 'tsvgr_opacity', 16:43:41 INFO - 'tart', 16:43:41 INFO - 'tscrollx', 16:43:41 INFO - 'cart', 16:43:41 INFO - 'tsvg_static']}, 16:43:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:43:41 INFO - 'talos_options': ['--disable-e10s'], 16:43:41 INFO - 'tests': ['tp5o']}, 16:43:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:43:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:43:41 INFO - 'talos_options': ['--disable-e10s', 16:43:41 INFO - '--xperf_path', 16:43:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:43:41 INFO - 'tests': ['tp5n']}, 16:43:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:43:41 INFO - 'talos_options': ['--xperf_path', 16:43:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:43:41 INFO - 'tests': ['tp5n']}}, 16:43:41 INFO - 'talos.zip': {'path': '', 16:43:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:43:41 INFO - Running post-action listener: _resource_record_post_action 16:43:41 INFO - [mozharness: 2017-01-14 00:43:41.994467Z] Finished populate-webroot step (success) 16:43:41 INFO - [mozharness: 2017-01-14 00:43:41.994555Z] Running create-virtualenv step. 16:43:41 INFO - Running pre-action listener: _resource_record_pre_action 16:43:41 INFO - Running main action method: create_virtualenv 16:43:41 INFO - Creating virtualenv /builds/slave/test/build/venv 16:43:41 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 16:43:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:43:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:43:42 INFO - Using real prefix '/usr' 16:43:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:43:42 INFO - Installing distribute.............................................................................................................................................................................................done. 16:43:44 INFO - Installing pip.................done. 16:43:44 INFO - Return code: 0 16:43:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:43:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:43:44 INFO - Reading from file tmpfile_stdout 16:43:44 INFO - Output received: 16:43:44 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) 16:43:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:43: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')]} 16:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43: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')]} 16:43:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:44 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 0x9c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xad8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc3850>, '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 0xd386d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd38b60>, '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-1484354049.71403-85007996', '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 16:43:44 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 16:43:44 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 16:43:44 INFO - Using env: {'DISPLAY': ':0', 16:43:44 INFO - 'HOME': '/home/cltbld', 16:43:44 INFO - 'LANG': 'en_US.UTF-8', 16:43:44 INFO - 'LANGUAGE': 'en_US:en', 16:43:44 INFO - 'LOGNAME': 'cltbld', 16:43:44 INFO - 'MAIL': '/var/mail/cltbld', 16:43:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:44 INFO - 'MOZ_NO_REMOTE': '1', 16:43:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:44 INFO - 'NO_EM_RESTART': '1', 16:43:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:44 INFO - 'PWD': '/builds/slave/test', 16:43:44 INFO - 'SHELL': '/bin/bash', 16:43:44 INFO - 'SHLVL': '1', 16:43:44 INFO - 'TERM': 'linux', 16:43:44 INFO - 'TMOUT': '86400', 16:43:44 INFO - 'USER': 'cltbld', 16:43:44 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1484354049.71403-85007996', 16:43:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:44 INFO - '_': '/tools/buildbot/bin/python'} 16:43:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:44 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 16:43:44 INFO - Cleaning up... 16:43:44 INFO - Return code: 0 16:43:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:43: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')]} 16:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43: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')]} 16:43:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:45 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 0x9c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xad8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc3850>, '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 0xd386d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd38b60>, '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-1484354049.71403-85007996', '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 16:43:45 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 16:43:45 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 16:43:45 INFO - Using env: {'DISPLAY': ':0', 16:43:45 INFO - 'HOME': '/home/cltbld', 16:43:45 INFO - 'LANG': 'en_US.UTF-8', 16:43:45 INFO - 'LANGUAGE': 'en_US:en', 16:43:45 INFO - 'LOGNAME': 'cltbld', 16:43:45 INFO - 'MAIL': '/var/mail/cltbld', 16:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:45 INFO - 'MOZ_NO_REMOTE': '1', 16:43:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:45 INFO - 'NO_EM_RESTART': '1', 16:43:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:45 INFO - 'PWD': '/builds/slave/test', 16:43:45 INFO - 'SHELL': '/bin/bash', 16:43:45 INFO - 'SHLVL': '1', 16:43:45 INFO - 'TERM': 'linux', 16:43:45 INFO - 'TMOUT': '86400', 16:43:45 INFO - 'USER': 'cltbld', 16:43:45 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1484354049.71403-85007996', 16:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:45 INFO - '_': '/tools/buildbot/bin/python'} 16:43:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:45 INFO - Downloading/unpacking psutil>=3.1.1 16:43:45 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 16:43:45 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 16:43:45 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 16:43:45 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 16:43:45 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 16:43:45 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 16:43:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:43:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:43:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:43:47 INFO - Installing collected packages: psutil 16:43:47 INFO - Running setup.py install for psutil 16:43:47 INFO - building 'psutil._psutil_linux' extension 16:43:47 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 16:43:47 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 16:43:47 INFO - building 'psutil._psutil_posix' extension 16:43:47 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 16:43:47 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 16:43:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:43:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:43:47 INFO - Successfully installed psutil 16:43:47 INFO - Cleaning up... 16:43:47 INFO - Return code: 0 16:43:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:43:47 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')]} 16:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:47 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')]} 16:43:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:47 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 0x9c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xad8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc3850>, '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 0xd386d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd38b60>, '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-1484354049.71403-85007996', '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 16:43:47 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 16:43:47 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 16:43:47 INFO - Using env: {'DISPLAY': ':0', 16:43:47 INFO - 'HOME': '/home/cltbld', 16:43:47 INFO - 'LANG': 'en_US.UTF-8', 16:43:47 INFO - 'LANGUAGE': 'en_US:en', 16:43:47 INFO - 'LOGNAME': 'cltbld', 16:43:47 INFO - 'MAIL': '/var/mail/cltbld', 16:43:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:47 INFO - 'MOZ_NO_REMOTE': '1', 16:43:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:47 INFO - 'NO_EM_RESTART': '1', 16:43:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:47 INFO - 'PWD': '/builds/slave/test', 16:43:47 INFO - 'SHELL': '/bin/bash', 16:43:47 INFO - 'SHLVL': '1', 16:43:47 INFO - 'TERM': 'linux', 16:43:47 INFO - 'TMOUT': '86400', 16:43:47 INFO - 'USER': 'cltbld', 16:43:47 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1484354049.71403-85007996', 16:43:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:47 INFO - '_': '/tools/buildbot/bin/python'} 16:43:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:43:48 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 16:43:48 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 16:43:48 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 16:43:48 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 16:43:48 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 16:43:48 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 16:43:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:43:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:43:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:43:50 INFO - Installing collected packages: mozsystemmonitor 16:43:50 INFO - Running setup.py install for mozsystemmonitor 16:43:50 INFO - Successfully installed mozsystemmonitor 16:43:50 INFO - Cleaning up... 16:43:50 INFO - Return code: 0 16:43:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:43:50 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')]} 16:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:50 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')]} 16:43:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:50 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 0x9c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xad8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc3850>, '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 0xd386d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd38b60>, '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-1484354049.71403-85007996', '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 16:43:50 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 16:43:50 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 16:43:50 INFO - Using env: {'DISPLAY': ':0', 16:43:50 INFO - 'HOME': '/home/cltbld', 16:43:50 INFO - 'LANG': 'en_US.UTF-8', 16:43:50 INFO - 'LANGUAGE': 'en_US:en', 16:43:50 INFO - 'LOGNAME': 'cltbld', 16:43:50 INFO - 'MAIL': '/var/mail/cltbld', 16:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:50 INFO - 'MOZ_NO_REMOTE': '1', 16:43:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:50 INFO - 'NO_EM_RESTART': '1', 16:43:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:50 INFO - 'PWD': '/builds/slave/test', 16:43:50 INFO - 'SHELL': '/bin/bash', 16:43:50 INFO - 'SHLVL': '1', 16:43:50 INFO - 'TERM': 'linux', 16:43:50 INFO - 'TMOUT': '86400', 16:43:50 INFO - 'USER': 'cltbld', 16:43:50 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1484354049.71403-85007996', 16:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:50 INFO - '_': '/tools/buildbot/bin/python'} 16:43:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:50 INFO - Downloading/unpacking jsonschema==2.5.1 16:43:50 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 16:43:50 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 16:43:50 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 16:43:50 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 16:43:50 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 16:43:50 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 16:43:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:43:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:43:52 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 16:43:52 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 16:43:52 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 16:43:52 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 16:43:52 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 16:43:52 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 16:43:52 INFO - Downloading functools32-3.2.3-2.tar.gz 16:43:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:43:52 INFO - warning: no files found matching '*.txt' 16:43:52 INFO - no previously-included directories found matching 'build' 16:43:52 INFO - no previously-included directories found matching 'dist' 16:43:52 INFO - no previously-included directories found matching '.git*' 16:43:52 INFO - Installing collected packages: jsonschema, functools32 16:43:52 INFO - Running setup.py install for functools32 16:43:52 INFO - warning: no files found matching '*.txt' 16:43:52 INFO - no previously-included directories found matching 'build' 16:43:52 INFO - no previously-included directories found matching 'dist' 16:43:52 INFO - no previously-included directories found matching '.git*' 16:43:52 INFO - Successfully installed jsonschema functools32 16:43:52 INFO - Cleaning up... 16:43:53 INFO - Return code: 0 16:43:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:53 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 0x9c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xad8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc3850>, '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 0xd386d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd38b60>, '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-1484354049.71403-85007996', '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 16:43:53 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 16:43:53 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 16:43:53 INFO - Using env: {'DISPLAY': ':0', 16:43:53 INFO - 'HOME': '/home/cltbld', 16:43:53 INFO - 'LANG': 'en_US.UTF-8', 16:43:53 INFO - 'LANGUAGE': 'en_US:en', 16:43:53 INFO - 'LOGNAME': 'cltbld', 16:43:53 INFO - 'MAIL': '/var/mail/cltbld', 16:43:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:53 INFO - 'MOZ_NO_REMOTE': '1', 16:43:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:53 INFO - 'NO_EM_RESTART': '1', 16:43:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:53 INFO - 'PWD': '/builds/slave/test', 16:43:53 INFO - 'SHELL': '/bin/bash', 16:43:53 INFO - 'SHLVL': '1', 16:43:53 INFO - 'TERM': 'linux', 16:43:53 INFO - 'TMOUT': '86400', 16:43:53 INFO - 'USER': 'cltbld', 16:43:53 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1484354049.71403-85007996', 16:43:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:53 INFO - '_': '/tools/buildbot/bin/python'} 16:43:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:43:53 INFO - Cleaning up... 16:43:53 INFO - Return code: 0 16:43:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:53 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 0x9c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xad8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc3850>, '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 0xd386d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd38b60>, '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-1484354049.71403-85007996', '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 16:43:53 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 16:43:53 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 16:43:53 INFO - Using env: {'DISPLAY': ':0', 16:43:53 INFO - 'HOME': '/home/cltbld', 16:43:53 INFO - 'LANG': 'en_US.UTF-8', 16:43:53 INFO - 'LANGUAGE': 'en_US:en', 16:43:53 INFO - 'LOGNAME': 'cltbld', 16:43:53 INFO - 'MAIL': '/var/mail/cltbld', 16:43:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:53 INFO - 'MOZ_NO_REMOTE': '1', 16:43:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:53 INFO - 'NO_EM_RESTART': '1', 16:43:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:53 INFO - 'PWD': '/builds/slave/test', 16:43:53 INFO - 'SHELL': '/bin/bash', 16:43:53 INFO - 'SHLVL': '1', 16:43:53 INFO - 'TERM': 'linux', 16:43:53 INFO - 'TMOUT': '86400', 16:43:53 INFO - 'USER': 'cltbld', 16:43:53 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1484354049.71403-85007996', 16:43:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:53 INFO - '_': '/tools/buildbot/bin/python'} 16:43:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:53 INFO - Downloading/unpacking blobuploader==1.2.4 16:43:53 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 16:43:53 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 16:43:53 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 16:43:53 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 16:43:53 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 16:43:53 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 16:43:55 INFO - Downloading blobuploader-1.2.4.tar.gz 16:43:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:43:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:43:55 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 16:43:55 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 16:43:55 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 16:43:55 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 16:43:55 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 16:43:55 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 16:43:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:43:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:43:55 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 16:43:55 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 16:43:55 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 16:43:55 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 16:43:55 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 16:43:55 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 16:43:56 INFO - Downloading docopt-0.6.1.tar.gz 16:43:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:43:56 INFO - Installing collected packages: blobuploader, requests, docopt 16:43:56 INFO - Running setup.py install for blobuploader 16:43:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:43:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:43:56 INFO - Running setup.py install for requests 16:43:56 INFO - Running setup.py install for docopt 16:43:56 INFO - Successfully installed blobuploader requests docopt 16:43:56 INFO - Cleaning up... 16:43:56 INFO - Return code: 0 16:43:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:43:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:56 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 0x9c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xad8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc3850>, '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 0xd386d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd38b60>, '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-1484354049.71403-85007996', '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 16:43:56 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 16:43:56 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 16:43:56 INFO - Using env: {'DISPLAY': ':0', 16:43:56 INFO - 'HOME': '/home/cltbld', 16:43:56 INFO - 'LANG': 'en_US.UTF-8', 16:43:56 INFO - 'LANGUAGE': 'en_US:en', 16:43:56 INFO - 'LOGNAME': 'cltbld', 16:43:56 INFO - 'MAIL': '/var/mail/cltbld', 16:43:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:56 INFO - 'MOZ_NO_REMOTE': '1', 16:43:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:56 INFO - 'NO_EM_RESTART': '1', 16:43:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:56 INFO - 'PWD': '/builds/slave/test', 16:43:56 INFO - 'SHELL': '/bin/bash', 16:43:56 INFO - 'SHLVL': '1', 16:43:56 INFO - 'TERM': 'linux', 16:43:56 INFO - 'TMOUT': '86400', 16:43:56 INFO - 'USER': 'cltbld', 16:43:56 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1484354049.71403-85007996', 16:43:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:56 INFO - '_': '/tools/buildbot/bin/python'} 16:43:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:43:57 INFO - Running setup.py (path:/tmp/pip-w1BhS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:43:57 INFO - Running setup.py (path:/tmp/pip-BOwnYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:43:57 INFO - Running setup.py (path:/tmp/pip-B44afw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:43:57 INFO - Running setup.py (path:/tmp/pip-Wv02cX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:43:57 INFO - Running setup.py (path:/tmp/pip-6fx0kL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:43:57 INFO - Running setup.py (path:/tmp/pip-I5U9mt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:43:57 INFO - Running setup.py (path:/tmp/pip-cq9wCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:43:57 INFO - Running setup.py (path:/tmp/pip-z0G4VE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:43:57 INFO - Running setup.py (path:/tmp/pip-hSjt3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:43:57 INFO - Running setup.py (path:/tmp/pip-hMFLw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:43:57 INFO - Running setup.py (path:/tmp/pip-vnQWIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:43:57 INFO - Running setup.py (path:/tmp/pip-RbnKS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:43:57 INFO - Running setup.py (path:/tmp/pip-6BYNGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:43:58 INFO - Running setup.py (path:/tmp/pip-JpR3Th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:43:58 INFO - Running setup.py (path:/tmp/pip-nZcpG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:43:58 INFO - Running setup.py (path:/tmp/pip-gXF66Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:43:58 INFO - Running setup.py (path:/tmp/pip-AiES3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:43:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:43:58 INFO - Running setup.py install for manifestparser 16:43:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:43:58 INFO - Running setup.py install for mozcrash 16:43:58 INFO - Running setup.py install for mozdebug 16:43:58 INFO - Running setup.py install for mozdevice 16:43:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:43:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:43:58 INFO - Running setup.py install for mozfile 16:43:58 INFO - Running setup.py install for mozhttpd 16:43:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:43:58 INFO - Running setup.py install for mozinfo 16:43:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:43:59 INFO - Running setup.py install for mozInstall 16:43:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:43:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:43:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:43:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:43:59 INFO - Running setup.py install for mozleak 16:43:59 INFO - Running setup.py install for mozlog 16:43:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:43:59 INFO - Running setup.py install for moznetwork 16:43:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:43:59 INFO - Running setup.py install for mozprocess 16:43:59 INFO - Running setup.py install for mozprofile 16:43:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:43:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:43:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:43:59 INFO - Running setup.py install for mozrunner 16:43:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:43:59 INFO - Running setup.py install for mozscreenshot 16:43:59 INFO - Running setup.py install for moztest 16:44:00 INFO - Running setup.py install for mozversion 16:44:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:44:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:44:00 INFO - Cleaning up... 16:44:00 INFO - Return code: 0 16:44:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:44:00 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')]} 16:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:00 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')]} 16:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:00 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 0x9c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xad8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc3850>, '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 0xd386d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd38b60>, '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-1484354049.71403-85007996', '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 16:44:00 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 16:44:00 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 16:44:00 INFO - Using env: {'DISPLAY': ':0', 16:44:00 INFO - 'HOME': '/home/cltbld', 16:44:00 INFO - 'LANG': 'en_US.UTF-8', 16:44:00 INFO - 'LANGUAGE': 'en_US:en', 16:44:00 INFO - 'LOGNAME': 'cltbld', 16:44:00 INFO - 'MAIL': '/var/mail/cltbld', 16:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:00 INFO - 'MOZ_NO_REMOTE': '1', 16:44:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:00 INFO - 'NO_EM_RESTART': '1', 16:44:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:00 INFO - 'PWD': '/builds/slave/test', 16:44:00 INFO - 'SHELL': '/bin/bash', 16:44:00 INFO - 'SHLVL': '1', 16:44:00 INFO - 'TERM': 'linux', 16:44:00 INFO - 'TMOUT': '86400', 16:44:00 INFO - 'USER': 'cltbld', 16:44:00 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1484354049.71403-85007996', 16:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:00 INFO - '_': '/tools/buildbot/bin/python'} 16:44:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:44:00 INFO - Running setup.py (path:/tmp/pip-9nyaCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:44:00 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)) 16:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:44:00 INFO - Running setup.py (path:/tmp/pip-9MUxl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:44:00 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)) 16:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:44:00 INFO - Running setup.py (path:/tmp/pip-qVuaMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:44:00 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)) 16:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:44:00 INFO - Running setup.py (path:/tmp/pip-xZk1Hs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:44:00 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)) 16:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:44:00 INFO - Running setup.py (path:/tmp/pip-bSQ1n3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:44:00 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)) 16:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:44:00 INFO - Running setup.py (path:/tmp/pip-yIymd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:44:00 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)) 16:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:44:00 INFO - Running setup.py (path:/tmp/pip-M9inDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:44:00 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)) 16:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:44:00 INFO - Running setup.py (path:/tmp/pip-B1dQsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:44:00 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)) 16:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:44:00 INFO - Running setup.py (path:/tmp/pip-iC0LCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:44:01 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)) 16:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:44:01 INFO - Running setup.py (path:/tmp/pip-GYZmmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:44:01 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)) 16:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:44:01 INFO - Running setup.py (path:/tmp/pip-IThDC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:44:01 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)) 16:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:44:01 INFO - Running setup.py (path:/tmp/pip-ZIPdyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:44:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:44:01 INFO - Running setup.py (path:/tmp/pip-R2t91B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:44:01 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)) 16:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:44:01 INFO - Running setup.py (path:/tmp/pip-8P8e4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:44:01 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)) 16:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:01 INFO - Running setup.py (path:/tmp/pip-z0bilX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:01 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)) 16:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:44:01 INFO - Running setup.py (path:/tmp/pip-JUXoPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:44:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:44:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:44:01 INFO - Running setup.py (path:/tmp/pip-Mdb0cA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:44:01 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)) 16:44:01 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)) 16:44:01 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)) 16:44:01 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)) 16:44:01 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)) 16:44:01 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)) 16:44:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:44:01 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 16:44:01 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 16:44:01 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 16:44:01 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 16:44:01 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 16:44:01 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 16:44:03 INFO - Downloading blessings-1.6.tar.gz 16:44:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:44:03 INFO - Installing collected packages: blessings 16:44:03 INFO - Running setup.py install for blessings 16:44:03 INFO - Successfully installed blessings 16:44:03 INFO - Cleaning up... 16:44:03 INFO - Return code: 0 16:44:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:44:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:44:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:44:04 INFO - Reading from file tmpfile_stdout 16:44:04 INFO - Current package versions: 16:44:04 INFO - argparse == 1.2.1 16:44:04 INFO - blessings == 1.6 16:44:04 INFO - blobuploader == 1.2.4 16:44:04 INFO - docopt == 0.6.1 16:44:04 INFO - functools32 == 3.2.3-2 16:44:04 INFO - jsonschema == 2.5.1 16:44:04 INFO - manifestparser == 1.1 16:44:04 INFO - mozInstall == 1.12 16:44:04 INFO - mozcrash == 1.0 16:44:04 INFO - mozdebug == 0.1 16:44:04 INFO - mozdevice == 0.49 16:44:04 INFO - mozfile == 1.2 16:44:04 INFO - mozhttpd == 0.7 16:44:04 INFO - mozinfo == 0.9 16:44:04 INFO - mozleak == 0.1 16:44:04 INFO - mozlog == 3.4 16:44:04 INFO - moznetwork == 0.27 16:44:04 INFO - mozprocess == 0.24 16:44:04 INFO - mozprofile == 0.28 16:44:04 INFO - mozrunner == 6.13 16:44:04 INFO - mozscreenshot == 0.1 16:44:04 INFO - mozsystemmonitor == 0.3 16:44:04 INFO - moztest == 0.8 16:44:04 INFO - mozversion == 1.4 16:44:04 INFO - psutil == 3.1.1 16:44:04 INFO - requests == 1.2.3 16:44:04 INFO - wsgiref == 0.1.2 16:44:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:04 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 0x9c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xad8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc3850>, '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 0xd386d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd38b60>, '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-1484354049.71403-85007996', '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 16:44:04 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 16:44:04 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 16:44:04 INFO - Using env: {'DISPLAY': ':0', 16:44:04 INFO - 'HOME': '/home/cltbld', 16:44:04 INFO - 'LANG': 'en_US.UTF-8', 16:44:04 INFO - 'LANGUAGE': 'en_US:en', 16:44:04 INFO - 'LOGNAME': 'cltbld', 16:44:04 INFO - 'MAIL': '/var/mail/cltbld', 16:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:04 INFO - 'MOZ_NO_REMOTE': '1', 16:44:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:04 INFO - 'NO_EM_RESTART': '1', 16:44:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:04 INFO - 'PWD': '/builds/slave/test', 16:44:04 INFO - 'SHELL': '/bin/bash', 16:44:04 INFO - 'SHLVL': '1', 16:44:04 INFO - 'TERM': 'linux', 16:44:04 INFO - 'TMOUT': '86400', 16:44:04 INFO - 'USER': 'cltbld', 16:44:04 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1484354049.71403-85007996', 16:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:04 INFO - '_': '/tools/buildbot/bin/python'} 16:44:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:04 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)) 16:44:04 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)) 16:44:04 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)) 16:44:04 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)) 16:44:04 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)) 16:44:04 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)) 16:44:04 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)) 16:44:04 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)) 16:44:04 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)) 16:44:04 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)) 16:44:04 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)) 16:44:04 INFO - Cleaning up... 16:44:04 INFO - Return code: 0 16:44:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:44:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9c81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xad8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc3850>, '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 0xd386d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd38b60>, '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-1484354049.71403-85007996', '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 16:44:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:44:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:44:04 INFO - Using env: {'DISPLAY': ':0', 16:44:04 INFO - 'HOME': '/home/cltbld', 16:44:04 INFO - 'LANG': 'en_US.UTF-8', 16:44:04 INFO - 'LANGUAGE': 'en_US:en', 16:44:04 INFO - 'LOGNAME': 'cltbld', 16:44:04 INFO - 'MAIL': '/var/mail/cltbld', 16:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:04 INFO - 'MOZ_NO_REMOTE': '1', 16:44:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:04 INFO - 'NO_EM_RESTART': '1', 16:44:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:04 INFO - 'PWD': '/builds/slave/test', 16:44:04 INFO - 'SHELL': '/bin/bash', 16:44:04 INFO - 'SHLVL': '1', 16:44:04 INFO - 'TERM': 'linux', 16:44:04 INFO - 'TMOUT': '86400', 16:44:04 INFO - 'USER': 'cltbld', 16:44:04 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1484354049.71403-85007996', 16:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:04 INFO - '_': '/tools/buildbot/bin/python'} 16:44:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:44:04 INFO - Cleaning up... 16:44:04 INFO - Return code: 0 16:44:04 INFO - Running post-action listener: _resource_record_post_action 16:44:04 INFO - Running post-action listener: _start_resource_monitoring 16:44:04 INFO - Starting resource monitoring. 16:44:04 INFO - [mozharness: 2017-01-14 00:44:04.591028Z] Finished create-virtualenv step (success) 16:44:04 INFO - [mozharness: 2017-01-14 00:44:04.591539Z] Running install step. 16:44:04 INFO - Running pre-action listener: _resource_record_pre_action 16:44:04 INFO - Running main action method: install 16:44:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:44:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:44:04 INFO - Reading from file tmpfile_stdout 16:44:04 INFO - Detecting whether we're running mozinstall >=1.0... 16:44:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:44:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:44:04 INFO - Reading from file tmpfile_stdout 16:44:04 INFO - Output received: 16:44:04 INFO - Usage: mozinstall [options] installer 16:44:04 INFO - Options: 16:44:04 INFO - -h, --help show this help message and exit 16:44:04 INFO - -d DEST, --destination=DEST 16:44:04 INFO - Directory to install application into. [default: 16:44:04 INFO - "/builds/slave/test"] 16:44:04 INFO - --app=APP Application being installed. [default: firefox] 16:44:04 INFO - mkdir: /builds/slave/test/build/application 16:44:04 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'] 16:44:04 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 16:44:22 INFO - Reading from file tmpfile_stdout 16:44:22 INFO - Output received: 16:44:22 INFO - /builds/slave/test/build/application/firefox/firefox 16:44:22 INFO - Running post-action listener: _resource_record_post_action 16:44:22 INFO - [mozharness: 2017-01-14 00:44:22.377743Z] Finished install step (success) 16:44:22 INFO - [mozharness: 2017-01-14 00:44:22.378079Z] Running run-tests step. 16:44:22 INFO - Running pre-action listener: _resource_record_pre_action 16:44:22 INFO - Running main action method: run_tests 16:44:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:44:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:44:22 INFO - Python 2.7.3 16:44:22 INFO - Return code: 0 16:44:22 INFO - grabbing minidump binary from tooltool 16:44:22 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')]} 16:44:22 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 0xdc3850>, '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 0xd386d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd38b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:44:22 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 16:44:22 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 16:44:22 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 16:44:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:44:22 INFO - Return code: 0 16:44:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:44:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:44:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:44:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:44:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:44:22 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/1484348225/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 16:44:22 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/1484348225/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 16:44:22 INFO - Using env: {'DISPLAY': ':0', 16:44:22 INFO - 'HOME': '/home/cltbld', 16:44:22 INFO - 'LANG': 'en_US.UTF-8', 16:44:22 INFO - 'LANGUAGE': 'en_US:en', 16:44:22 INFO - 'LOGNAME': 'cltbld', 16:44:22 INFO - 'MAIL': '/var/mail/cltbld', 16:44:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:44:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:44:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:22 INFO - 'MOZ_NO_REMOTE': '1', 16:44:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:44:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:22 INFO - 'NO_EM_RESTART': '1', 16:44:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:22 INFO - 'PWD': '/builds/slave/test', 16:44:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:44:22 INFO - 'SHELL': '/bin/bash', 16:44:22 INFO - 'SHLVL': '1', 16:44:22 INFO - 'TERM': 'linux', 16:44:22 INFO - 'TMOUT': '86400', 16:44:22 INFO - 'USER': 'cltbld', 16:44:22 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1484354049.71403-85007996', 16:44:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:22 INFO - '_': '/tools/buildbot/bin/python'} 16:44:22 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/1484348225/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 16:44:22 INFO - mozversion application_buildid: 20170113145705 16:44:22 INFO - mozversion application_changeset: 4ef05cc6af4ec1ff02dc6ceb0e85c1ee3a3f9e86 16:44:22 INFO - mozversion application_display_name: Nightly 16:44:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:44:22 INFO - mozversion application_name: Firefox 16:44:22 INFO - mozversion application_remotingname: firefox 16:44:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:44:22 INFO - mozversion application_vendor: Mozilla 16:44:22 INFO - mozversion application_version: 53.0a1 16:44:22 INFO - mozversion platform_buildid: 20170113145705 16:44:22 INFO - mozversion platform_changeset: 4ef05cc6af4ec1ff02dc6ceb0e85c1ee3a3f9e86 16:44:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:44:22 INFO - mozversion platform_version: 53.0a1 16:44:22 INFO - using testdate: 1484354662 16:44:22 INFO - actual date: 1484354662 16:44:22 INFO - starting webserver on 'localhost:36480' 16:44:22 INFO - SUITE-START | Running 2 tests 16:44:22 INFO - TEST-START | dromaeo_css 16:44:22 INFO - operating with platform_type : linux_ 16:44:22 INFO - Initialising browser for dromaeo_css test... 16:44:22 INFO - TEST-INFO | started process 10057 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGeGyYt/profile http://localhost:36480/getInfo.html) 16:44:26 INFO - PROCESS | 10057 | __metrics Screen width/height:1600/1200 16:44:26 INFO - PROCESS | 10057 | colorDepth:24 16:44:26 INFO - PROCESS | 10057 | Browser inner width/height: 1024/697 16:44:26 INFO - PROCESS | 10057 | __metrics 16:44:26 INFO - PROCESS | 10057 | 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" 16:44:26 INFO - PROCESS | 10057 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:44:27 INFO - PROCESS | 10057 | console.error: PushService: 16:44:27 INFO - PROCESS | 10057 | stateChangeProcessEnqueue: Error transitioning state 16:44:27 INFO - PROCESS | 10057 | UnknownError 16:44:28 INFO - TEST-INFO | 10057: exit 0 16:44:28 INFO - Browser initialized. 16:44:28 INFO - Running cycle 1/1 for dromaeo_css test... 16:44:28 INFO - TEST-INFO | started process 10140 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGeGyYt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:44:40 INFO - PROCESS | 10140 | RSS: Main: 147968000 16:44:40 INFO - PROCESS | 10140 | 16:47:41 INFO - PROCESS | 10140 | Cycle 1(1): loaded http://localhost:36480/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36480/tests/dromaeo/cssquery-ext.html) 16:47:42 INFO - PROCESS | 10140 | RSS: Main: 291389440 16:47:42 INFO - PROCESS | 10140 | 16:49:29 INFO - PROCESS | 10140 | ************************* 16:49:29 INFO - PROCESS | 10140 | A coding exception was thrown and uncaught in a Task. 16:49:29 INFO - PROCESS | 10140 | 16:49:29 ERROR - PROCESS | 10140 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:49:29 INFO - PROCESS | 10140 | Full stack: 16:49:29 INFO - PROCESS | 10140 | ************************* 16:50:45 INFO - PROCESS | 10140 | Cycle 1(1): loaded http://localhost:36480/tests/dromaeo/cssquery-ext.html (next: http://localhost:36480/tests/dromaeo/cssquery-jquery.html) 16:50:45 INFO - PROCESS | 10140 | RSS: Main: 240332800 16:50:45 INFO - PROCESS | 10140 | 16:53:47 INFO - PROCESS | 10140 | Cycle 1(1): loaded http://localhost:36480/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36480/tests/dromaeo/cssquery-mootools.html) 16:53:48 INFO - PROCESS | 10140 | RSS: Main: 182575104 16:53:48 INFO - PROCESS | 10140 | 16:56:50 INFO - PROCESS | 10140 | Cycle 1(1): loaded http://localhost:36480/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36480/tests/dromaeo/cssquery-prototype.html) 16:56:50 INFO - PROCESS | 10140 | RSS: Main: 227352576 16:56:51 INFO - PROCESS | 10140 | 16:59:53 INFO - PROCESS | 10140 | Cycle 1(1): loaded http://localhost:36480/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36480/tests/dromaeo/cssquery-yui.html) 16:59:54 INFO - PROCESS | 10140 | RSS: Main: 187330560 16:59:54 INFO - PROCESS | 10140 | 17:02:57 INFO - PROCESS | 10140 | Cycle 1(1): loaded http://localhost:36480/tests/dromaeo/cssquery-yui.html (next: http://localhost:36480/tests/dromaeo/cssquery-dojo.html) 17:02:57 INFO - PROCESS | 10140 | RSS: Main: 278261760 17:02:57 INFO - PROCESS | 10140 | 17:02:57 INFO - PROCESS | 10140 | __start_tp_report 17:02:57 INFO - PROCESS | 10140 | _x_x_mozilla_page_load 17:02:57 INFO - PROCESS | 10140 | _x_x_mozilla_page_load_details 17:02:57 INFO - PROCESS | 10140 | |i|pagename|runs| 17:02:57 INFO - PROCESS | 10140 | |0;dojo.html;3165.7150856422923;3235.0780027692113;3270.149761062124;3272.0347497488237;3274.6889045540697;5388.245645609618;5420;5476.452354764521;5519.392866784656;5567.777288908444;5482.616216864821;5490.478404551571;5534.778608855641;5567.693776842272;5619.044762390393;4898.093852637265;4913.778879950393;4937.407511098673;4951.430585482662;5008.524190201943;5009.749512524378;5028.522290382408;5029.321041659366;5040.621953353495;5042.445331013586;4780.163471392492;4839.201531747258;4932.728699921503;4950.034743225073;5041.59667226621;4885.047415753929;4932.654714170009;4943.134951383529;4944.975275123637;5023.7236951967625;4888.780004899752;4898.289747986558;4905.656604037718;4916.901661966776;4935.407751069859;5374.731263436852;5553.7778488860395;5556;5558.666480011212;5562;5832.387599302055;5850.970745146247;5861.4724674779045;5876.4123587641325;6012.6392416455155;5986.640801551921;6000.699965001732;6008.729607167688;6010.75956961721;6012.639241645472;5563.082091454905;5570.693611851306;5574.052411090165;5578.63738856973;5586.162075688598;5944.791932282349;5971.611845230133;6009.909851352233;6010.699465026732;6017.909731354033;5763.423657634287;5802.738876750556;5803.88392232153;5814;5858.443447872445;5742.483176514133;5793.478586927113;5848.736806843703;5900;5913.9112913306335;5859.355470898283;5891.587588868738;5930.021546444788;6021.5182785377065;6023.548233882477;5925.318588362307;5967.76128954837;5989.041753319448;6000;6008.729607167688;4627.838025669085;4629.560191781776;4630.83792067276;4633.652476064309;4671.95328046722;4080.265552200573;4110.034141976633;4112.814923328458;4116.094459218967;4183.769892655872;5594.748236329375;5633.295838020247;5638.295213098363;5683.744231509592;5744.023516002289;5928.436798504135;5947.672877991666;5986.431289027535;5987.940120598825;6001.729922153513;5412.458754124556;5676.858078547987;5684.687342196219;5685.459881311269;5698.943010569841;4947.282644016597;5129.333186685707;5197.220416937414;5206.73966301691;5208.166693329049;6275;6276.089966954766;6281.403266689748;6286.15136956505;6286.5599408041;6028;6033;6037.969810150921;6041.426064523863;6043.244594425697;5946.672932988728;6012.579119461596;6058.242719660043;6060.151578779062;6091.725872335667;5779.162021506942;5826.621269617462;5843.1235314703135;5862.413758624103;5876.147958546072;5878.2358293421585;5960.5827592068135;5967.552433567413;5983;5985.581009329305;5680.375158732453;5748.223989761329;5814.331351894586;5818;5835.620684655653;5895.322037965689;5900.380460051632;5905.35041145465;5907.586468947305;5964.761409543569;5882.411758824083;5897.351291357862;5904.409559044061;5909.349971503045;5909.409059094228;5649.039663257174;5702.429757024431;5702.45826646468;5739.282589676291;5835.387284335084;5668.348139963957;5712.514436272797;5720.342160651412;5753;5764.337101233412 17:02:57 INFO - PROCESS | 10140 | |1;ext.html;553.8504603756985;566.8214512428584;577.8873119741651;595.8718875441779;596.9821454420214;34350.65649343506;44548.33177502336;45865;46321.30518042232;50157.74921125389;46969.53030469694;47202;47339.52660473394;47341.52658473414;47353.52646473534;8905.109489051092;9067.773305667346;9090.681826136086;9091.318151138657;9107.180353768159;8639.39524233304;8847.690330838423;10718.571257149704;10940.890591094067;10944.945275273612;10905.400202988832;10963.890361096366;10964.396958167337;10967.451627418637;10972.177086718488;10796.730081747979;10826.783464330669;10841.506453515696;10869.782604347869;10872.782544349147;10687.893121068846;10764.24650274481;10766.40784756838;10767.676969690921;10770.138388928866;42393.1521369574;42581.78709106435;42712.145757084996;42715;42755.57244427547;4177.310743727312;4218.535961044283;4234.026937496272;4244.469441319835;4286.721363111388;31599.52600710991;33193.3361332772;33369.83315083433;33377.6662233377;33393.6660633393;4292.871213863589;4336.544662810391;4413.801378937956;4570.497245303014;4577.404937358122;320513;321093;321823;321961;322117;61691.38308616946;61736.38263617396;62097;62225.68887155626;62230;64333.67833160804;64490;64541;64664;64664.67667661726;15919.920400398156;16057.23370429252;16088.276027578788;16131.354745810271;16134.515964521082;10435.113015393777;10720.088792452729;12288.262704237774;12361.381930903419;12362.814557781641;17549.210285536927;17870.91064544669;17880;18293.176807043714;18428.539286517676;6948.652567371712;7006.859862802716;7059.541129826544;7120.786376408716;7252.311030452099;940.1303793990531;950.254050570299;953.8950715421298;962.9903700962901;971.1065819446127;30652.846735766623;32549.51175732366;32704.509432358533;32875.50686739701;33032.66967330344;1037.7976294622626;1133.7052366384798;1146.529922731676;1162.2793867802018;1171.6133675886938;16050.919745401432;17169.48491545256;17445;17489.98997751181;17575;436432;436434;442620;443418;444522;61865.69067154726;61910.38089619136;61988.69005654943;62428.375716243165;62540.06189907155;1452.4771082410323;1485.3909896941987;1491.2767307855681;1492.8133983252094;1501.992490037543;30169.849150754984;31784.68215317817;32044.679553205104;32285.838570806995;32646.83676581697;52714.73642631762;53655.731721341144;53693.73153134209;53738;53811.461885380646;372818;373777;373988;374001;374753;24520.14179503709;25183.37041573975;41898.79050604849;42099.158016838875;42165.78917105395;38979.610203897595;39815.60184398119;43603.56396435995;44323.556764431945;45181;35733.46399803953;38894.222115556964;39072.02319942024;40624.79687601543;40820;37655.82175538744;38255.23489530249;38778.61221387863;39465.40801887916;40103.39844902387;38589.80705096456;39530.2093958125;39537;39635;39815.80092099521;32643.673563265012;33156.50265246072;33823.83088084544;34404.655953440146;34811.825940870134;26398.472030558896;26423.471530568895;26507.072252471073;26620.866895665396;26660.333491662088 17:02:57 INFO - PROCESS | 10140 | |2;jquery.html;420.8695304455617;421.83126749300277;424.77699207915833;428.6206707064248;439.27519592672087;19937.900310498462;20624;21074.789252107512;21214.89392553039;21364.4658883528;19239.61520769584;20027.89986050068;20330.186792528282;20748.688769668468;20845.27041553546;5786.508146807527;5999.970000149993;6034.24571928509;6040.187943616919;6045.637261764286;5797.942020579803;5908.9409105909035;5964.1650168976375;6006.909896351558;6009.338972712998;5978.8804223915495;5986.850328741794;5992.370801065891;5992.7303271352675;6001.639901605896;5751.281089863767;5851.707414629294;5864.677442740647;5905.822825315247;5968.462838344548;5228.424873263976;5247.134222853225;5308.283381743454;5315.867103322409;5321.281626980347;23403.648945265835;24776.3805904852;24844.875775621007;25039.87480062606;25132.874335628207;2802.2714094335415;2806.7052959439375;2816.8732407041734;2820.1680504251294;2821.858907054639;14627.488037918622;15368.462103826425;15596.220188990505;15805.130717810516;16295;1918.2039453626728;1947.260041184341;1950.0639692947464;1965.7346258255095;2010.5174758058106;89176.55411722965;90232;91901.99999999933;92527;93203;11325.660230193107;11537.538498459968;11696.70758231034;11767.705807354885;11826.11304152192;16427.342906283615;16449.6710065798;16450.83549164493;16454;16486.83513164877;8184.427090103635;8332.833343333099;8364.58177091143;8491.74524764258;8602.354823388147;7807.882881756778;7875.763727088197;7950.204979502119;8124.390670699721;8151.470154439942;7141.464390170758;7188.209296977328;7261.273872612802;7355.1541572719825;7369.668364923591;1957.9216831326587;2008.5380362516703;2034.0948278016438;2042.428120126367;2044.8977551122384;890.5191196753681;895.9372843900865;902.2195800632537;908.5457271364318;922.8062106957614;19700.70448943267;20186.79813201849;20258.29095981663;20584;20585.838486958954;930.7719608695777;934.2619330728648;936.3913456253354;939.8167357365248;944.1313991128178;10981.780364392667;11377.658670239905;11456.312621242752;12686.682832929251;12760.29818359999;664655;670322;676179;693051;695007;74882.25117748862;79487.99999999885;80725.19274807294;110149;112916;1086.5979587552497;1140.0822338017974;1152.1474109159162;1153.1754795321385;1175.0540814644294;18482.722759158893;18597.628047438706;19413.4175974721;19432.4170274892;19441.416757497296;44821;45534.316985244586;45792.31311530263;46293.768531157126;47416.20670346433;64081.67959160174;64116.679416604486;64511.87137221956;65205;65432.67283663551;8706.56467176626;8797.47215167092;9151.222146117654;9166.129217724305;9273.30450216223;8349.457285276438;12270.754584908073;13692.794608080687;14003.299835008005;14080.22558759278;10827.945860270649;11406.657800266004;11448.599299024494;11726.765464690488;11955.163138580563;11537.82693259585;11692.181547291608;11853.34806585646;12062.396880156133;12088.576899808464;10799.514021869192;11927.940360298144;11969.820452693391;12262.08034397406;12279.386030698251;7935.0874649416055;8274.503529788231;8606;8733.694320698745;8740.78148046304;10689.732756681145;12111.878881211427;12294.87705122973;12379.381030948236;12547.3098979557 17:02:57 INFO - PROCESS | 10140 | |3;mootools.html;1422.1751384197166;1426.61481400022;1437.3172742947095;1456.6067161866295;1461.5469204546594;7739.496932699378;8114.472559283649;8225.794355141124;8229.753107406787;8242.340612750973;7121.2878712128895;7272.96363518183;7812.101608315045;8029.959850200756;8128.187181281884;2373.359193017884;2400.435897564071;2409.855408675476;2414.14297924237;2414.6860908081926;2230;2307.042577330406;2308.8152947764224;2313.1094528606523;2313.2597568777996;2042.6221149087467;2100.789921007902;2296.5980953333183;2346.2022912209845;2351.6119840226343;2279;2299.8850057497143;2318.6174281243575;2320.9071637134493;2321.7562155973546;2337.6960995070704;2345.8944347504234;2366.5740166769974;2369.774871387233;2371.253055287596;8228.547429891354;8287.751367458986;8291.792705182359;8296.626651800683;8297.170282971714;5071.112555302807;5208.322918020633;5208.8958220835375;5209.6874187548865;5211.24436956643;3126.452870747633;3234.4313008191007;3347.5146103815055;3350.2964377480757;3416.3167366526795;1355.9050866439354;1370.7327071221116;1414.7453458377488;1414.9575512734634;1468.8090548228663;11154;11208.21542492026;11218.046466050313;11218.214724969173;11226.101911847032;4329.15581461612;4602.7698615069785;4663.230566956414;4690.15577196108;4740.454847692559;9591.184749296248;9611.231101511863;9628.807423851484;9642.566084526074;9647.421154730739;5248.396434410091;5271.973640131851;5279.815206467755;5282.550983166474;5283.682979021271;4798.616110711135;4819.783109760069;4856.028794241166;4857.198562237191;4867.70793752376;3833.923321533554;3913.68891421377;3955.64399204073;4012.7391719538136;4115.835366585363;1172.8006238939402;1281.1608396500308;1292.7866901961258;1293.4567481657725;1305.8117113426736;808.4340961327094;930.5161316115582;939.0703203828161;947.2374738335568;986.40815510693;5153.819616313411;5291.894162116736;5308.097623404031;5372.301600791872;5409.7295135243085;1030.1861529391697;1035.880873699519;1047.9947600262103;1058.523664351045;1084.2789544952518;3519.9296014079573;3578.624244454295;3594.101474631342;3594.98202508991;3629.709623230188;9647.9035209647;9997.450140242356;10003.24975626831;10003.44981026036;10025.849612255823;9908.80182396348;9911.45486998222;9917.256205784595;9920.454375009444;9924.454155021544;7325.7802265932105;7544.358729508053;7603.809904752426;7753;7794.103678077094;5554.50009499147;5693.658380497018;5720.3707592165665;5825.475707186373;5871.882562348644;8540.70107546233;8744.868826967728;8981.056989016059;9067;9067.183953444222;8825.91174088251;8987.146221108984;9072.138146876036;9089.59096840657;9135.40619859707;7178.892316615359;7270.236625154283;7305.853882922205;7326.3040011198855;7331.3768329692575;7823.2567906048835;7844.529328240324;7887.3295769857905;7891.250331218525;7917.089534703583;7099.325564071405;7162.89255661155;7183.5330703504105;7221.747238846615;7374.963125184339;7040.084788977605;7096.858062838817;7113.253108423541;7122.821929451805;7143.642817858982;6321.399467050623;6337.873242535031;6362.395572420613;6407.103005579316;6425.614463132227;4872.6832755870755;4919.926201107058;4921.630877684116;4926.103450171638;5014.899702006012;5018.4981501849525;5140.3831540215415;5183.352080989876;5189.506996835295;5190.091733946469 17:02:57 INFO - PROCESS | 10140 | |4;prototype.html;386.327789646016;403.98586049488273;410.5073911306432;412.83899279281064;416.5979829464566;5262.5263726264675;5299.761510732017;5312.389075256347;5318.78724851006;5358.142697168454;5200.453952335007;5258.342707161605;5301.602379821519;5306;5306.893862122755;3843.846246150151;4150.3774433835015;4163.7293575917465;4168.916621667565;4187.685923555746;4164.437800896871;4167.187398457302;4186.74879507229;4188.350805625118;4194.517630472489;4161.854335098272;4172.165566886635;4178.582141785828;4189.748615083089;4209.4317267169;3883;4002.419649150857;4078.4290199372113;4189.476315460567;4194.601512856289;3601.243738814852;3603.765755225902;3605.8737944171826;3606.5852426970973;3610.981945090284;5144.4083930348115;5150.459201783796;5159.22611608258;5166.173412254021;5195.558377537914;4578.381918441034;4710.222813235812;4729.304296550968;4758.928616070762;4760.7619619018915;5512.80705175317;5517.475839795253;5521.309836270466;5551.528120109755;5556.91664625031;3993.7803420811842;4003.2994226010624;4008.2584721826265;4011.65900898424;4051.9392209116886;5134.486551344873;5556.722163891789;5589.931725261598;5808.97095514524;5810.912836307459;4106.650934670586;4107.466029416157;4114.691398145151;4138.958610413918;4145.647619952338;4176.6843444315555;4179.12238429927;4182.414461975326;4202.810873510638;4207.5161356444405;4521.276595744731;4637.721736695809;4734.130018642686;4756.286557016475;4756.6432517561325;5506.504414602705;5545.750441230073;5591.3569939456665;5594.720263986785;5597.440255974451;1477.5567329801017;1486.869978816086;1488.159190057614;1505.4655597263034;1507.947221847252;1028.7428142964259;1090.1987039525943;1094.3762055628374;1102.399192440122;1107.7175320293434;5143.968132587682;5192.273081768555;5233.031889100528;5251.8161864335325;5258.39528454225;5491;5495.258140151109;5518.972405138029;5522.784987302787;5579.69311687861;4903.362562866804;5174.275601415805;5177.301064356264;5189.247559103909;5194.84415467529;2927.253550344691;2947.8208716513136;2948.469275530425;2954.6454425469083;2954.8670309836107;5725.31296244445;5762.222100016528;5770.480656740913;5771.547092485677;5776.480116789509;5452.064517096453;5537.861553461115;5833.212516310244;5848.356680765112;5852.94147058524;5741.741621627037;5809.302883653989;5885.882282354329;5903.970480147744;5910.408959104056;5701.515371193329;5707.1153971134545;5743.10981797822;5752.769889204553;5761.39505351932;5519.337679478328;5594.552435805207;5601.187827765033;5602.719864006865;5627.409122042127;5878;5893.5874488785375;5893.675847828411;5894.970525147347;5906.4093590642315;4116.197341518375;4130.91738165241;4152.563980781974;4153.875383738493;4158;5528.419515950928;5655.575831812713;5661.377248502579;5694.515966142759;5707.1724599933605;5531.2532808072;5535.197396377584;5557.02752018387;5564.970480461127;5582.665040097607;5365.731713414391;5512.779488820403;5585.1901474286815;5596.552275818006;5602.299712535933;5537.390887002346;5538.944610553843;5551.750171242385;5552.833414997556;5553.278073850373;5556.944430555643;5567.610267281251;5572;5582.860428489158;5591.329040515164;5185.403678577012;5385.299911011543;5392.433794451683;5400.594955378284;5416.7270691388285 17:02:57 INFO - PROCESS | 10140 | |5;yui.html;749.2694622742827;789.8064974081351;792.0495405513385;848.2874385516167;857.245623851011;15535.378584856606;16579.83420165798;16695.081770502617;16964.74552881708;16987.405440809573;13781.793273100911;13887.930560347184;13909.791353129685;13915.652108697263;13917.37371818268;635.4471609699556;642.6593905230235;728.3081072980663;734.6620554544916;738.8263758016861;739.2496615934831;745.6532712288785;746.0897704800135;746.3693179263514;746.9551826890404;793.59526641413;793.845200185964;794.2097612875198;794.3526026288556;794.9682012719513;675.152683382352;683.4122654517112;759.1080480435521;788.6727008291581;790.0913948958714;567.741677536724;580.2514755964801;580.431177446101;580.4659713063992;580.8199458167982;15716.135612541306;16270.26783794732;16279.104649244287;16293.185340732916;16300.429484968088;14403.71192576153;14594.489192878198;14961.551153465414;15053.096814191184;15209.391624335014;11927.701807454796;11933;13439;13557.186568805902;13644.113132646346;4500.954990450086;4576.153411618861;4793.952060479385;4801.519848015206;4804.303376010494;75021;75669;75794;76473.61763191149;77580.61209693972;10488.475576221312;10502.4223667699;10878.836817447585;10937.726556836144;10947.124230061576;19810.910399928143;20181.192752289742;20186.899065504578;20343.186272548934;20389.694154587694;7485.251474852471;7551.697932082765;7656.885146722803;7716.961415192888;7729.149793522708;4323.654107671378;4343.435353404037;4354.325079612665;4385.199579623664;4476.149531588988;3518.437050071976;3608.440691692792;3614.6023937366867;3616.511770910946;3872.0707030312524;683.9794806155824;692.7713854428026;697.2539382860291;700.5796522086707;708.9361957423856;753.6721526136148;761.4451635870985;779.8479296537121;795.4074214709963;806.9318723201492;10576.153907687367;10597.894021059845;10789.892101079045;10802.67591972242;10923.617673381394;728.9648698847649;764.9120351159577;781.9296263336327;783.0994356489969;795.2127393880018;4765.380500534909;5078.263651770472;5143.434222235551;5147.510986456281;5149.742512874342;76324.61837690776;77143.91424343076;79581.60209198917;79993;81386;50729.23906141411;52528.47471525312;69356;70080.2991970084;70153.2984670157;56056.43943560676;56093.15860262099;56956.57608559819;57152;58520.414795851495;10496.265261431932;10709.57161713554;10784.137269018303;10880.183986200907;11175.10599152082;35927.28145437129;40062;41333.58666413297;41735.7913210432;42295;47868.28197576969;49330.26004609862;49464.25803612877;50274;52287;12852;12957.22256664603;12979.675508112372;12986.545470908473;13251.734965300833;14126.223057731924;14681.559553213421;14686.175168009553;15057.171855547613;15289.77065344043;13617.319134043457;14009;14050.648733781738;14081.788773168615;14096.224707640768;13692.863071369158;13699.931500342833;14130.081544699562;14383.496577619733;14496.637584060483;13605.183688978694;13692.863071369158;14067.577972660836;14153.575392737823;14247.572572822832;10102.625882917362;10166.542505587415;10244.948775256076;10388.272820902464;10629.787404251718;10681.305715128492;10758.354498730101;10798.244122911636;10940.39827809478;10986.780264394827 17:02:57 INFO - PROCESS | 10140 | __end_tp_report 17:02:57 INFO - PROCESS | 10140 | __start_cc_report 17:02:57 INFO - PROCESS | 10140 | _x_x_mozilla_cycle_collect,1371 17:02:57 INFO - PROCESS | 10140 | __end_cc_report 17:02:57 INFO - PROCESS | 10140 | __startTimestamp1484355777500__endTimestamp 17:02:57 INFO - PROCESS | 10140 | 17:02:57 INFO - PROCESS | 10140 | ------- Summary: start ------- 17:02:57 INFO - PROCESS | 10140 | Number of tests: 6 17:02:57 INFO - PROCESS | 10140 | 17:02:57 INFO - PROCESS | 10140 | [#0] dojo.html Cycles:165 Average:5511.74 Median:5742.48 stddev:630.84 (11.0%) stddev-sans-first:605.34 17:02:57 INFO - PROCESS | 10140 | Values: 3165.7 3235.1 3270.1 3272.0 3274.7 5388.2 5420.0 5476.5 5519.4 5567.8 5482.6 5490.5 5534.8 5567.7 5619.0 4898.1 4913.8 4937.4 4951.4 5008.5 5009.7 5028.5 5029.3 5040.6 5042.4 4780.2 4839.2 4932.7 4950.0 5041.6 4885.0 4932.7 4943.1 4945.0 5023.7 4888.8 4898.3 4905.7 4916.9 4935.4 5374.7 5553.8 5556.0 5558.7 5562.0 5832.4 5851.0 5861.5 5876.4 6012.6 5986.6 6000.7 6008.7 6010.8 6012.6 5563.1 5570.7 5574.1 5578.6 5586.2 5944.8 5971.6 6009.9 6010.7 6017.9 5763.4 5802.7 5803.9 5814.0 5858.4 5742.5 5793.5 5848.7 5900.0 5913.9 5859.4 5891.6 5930.0 6021.5 6023.5 5925.3 5967.8 5989.0 6000.0 6008.7 4627.8 4629.6 4630.8 4633.7 4672.0 4080.3 4110.0 4112.8 4116.1 4183.8 5594.7 5633.3 5638.3 5683.7 5744.0 5928.4 5947.7 5986.4 5987.9 6001.7 5412.5 5676.9 5684.7 5685.5 5698.9 4947.3 5129.3 5197.2 5206.7 5208.2 6275.0 6276.1 6281.4 6286.2 6286.6 6028.0 6033.0 6038.0 6041.4 6043.2 5946.7 6012.6 6058.2 6060.2 6091.7 5779.2 5826.6 5843.1 5862.4 5876.1 5878.2 5960.6 5967.6 5983.0 5985.6 5680.4 5748.2 5814.3 5818.0 5835.6 5895.3 5900.4 5905.4 5907.6 5964.8 5882.4 5897.4 5904.4 5909.3 5909.4 5649.0 5702.4 5702.5 5739.3 5835.4 5668.3 5712.5 5720.3 5753.0 5764.3 17:02:57 INFO - PROCESS | 10140 | 17:02:57 INFO - PROCESS | 10140 | [#1] ext.html Cycles:180 Average:55528.55 Median:38836.42 stddev:100482.11 (258.7%) stddev-sans-first:100679.21 17:02:57 INFO - PROCESS | 10140 | Values: 553.9 566.8 577.9 595.9 597.0 34350.7 44548.3 45865.0 46321.3 50157.7 46969.5 47202.0 47339.5 47341.5 47353.5 8905.1 9067.8 9090.7 9091.3 9107.2 8639.4 8847.7 10718.6 10940.9 10944.9 10905.4 10963.9 10964.4 10967.5 10972.2 10796.7 10826.8 10841.5 10869.8 10872.8 10687.9 10764.2 10766.4 10767.7 10770.1 42393.2 42581.8 42712.1 42715.0 42755.6 4177.3 4218.5 4234.0 4244.5 4286.7 31599.5 33193.3 33369.8 33377.7 33393.7 4292.9 4336.5 4413.8 4570.5 4577.4 320513.0 321093.0 321823.0 321961.0 322117.0 61691.4 61736.4 62097.0 62225.7 62230.0 64333.7 64490.0 64541.0 64664.0 64664.7 15919.9 16057.2 16088.3 16131.4 16134.5 10435.1 10720.1 12288.3 12361.4 12362.8 17549.2 17870.9 17880.0 18293.2 18428.5 6948.7 7006.9 7059.5 7120.8 7252.3 940.1 950.3 953.9 963.0 971.1 30652.8 32549.5 32704.5 32875.5 33032.7 1037.8 1133.7 1146.5 1162.3 1171.6 16050.9 17169.5 17445.0 17490.0 17575.0 436432.0 436434.0 442620.0 443418.0 444522.0 61865.7 61910.4 61988.7 62428.4 62540.1 1452.5 1485.4 1491.3 1492.8 1502.0 30169.8 31784.7 32044.7 32285.8 32646.8 52714.7 53655.7 53693.7 53738.0 53811.5 372818.0 373777.0 373988.0 374001.0 374753.0 24520.1 25183.4 41898.8 42099.2 42165.8 38979.6 39815.6 43603.6 44323.6 45181.0 35733.5 38894.2 39072.0 40624.8 40820.0 37655.8 38255.2 38778.6 39465.4 40103.4 38589.8 39530.2 39537.0 39635.0 39815.8 32643.7 33156.5 33823.8 34404.7 34811.8 26398.5 26423.5 26507.1 26620.9 26660.3 17:02:57 INFO - PROCESS | 10140 | 17:02:57 INFO - PROCESS | 10140 | [#2] jquery.html Cycles:180 Average:35391.31 Median:1621.36 stddev:111468.55 (6875.0%) stddev-sans-first:111750.31 17:02:57 INFO - PROCESS | 10140 | Values: 420.9 421.8 424.8 428.6 439.3 19937.9 20624.0 21074.8 21214.9 21364.5 19239.6 20027.9 20330.2 20748.7 20845.3 5786.5 6000.0 6034.2 6040.2 6045.6 5797.9 5908.9 5964.2 6006.9 6009.3 5978.9 5986.9 5992.4 5992.7 6001.6 5751.3 5851.7 5864.7 5905.8 5968.5 5228.4 5247.1 5308.3 5315.9 5321.3 23403.6 24776.4 24844.9 25039.9 25132.9 2802.3 2806.7 2816.9 2820.2 2821.9 14627.5 15368.5 15596.2 15805.1 16295.0 1918.2 1947.3 1950.1 1965.7 2010.5 89176.6 90232.0 91902.0 92527.0 93203.0 11325.7 11537.5 11696.7 11767.7 11826.1 16427.3 16449.7 16450.8 16454.0 16486.8 8184.4 8332.8 8364.6 8491.7 8602.4 7807.9 7875.8 7950.2 8124.4 8151.5 7141.5 7188.2 7261.3 7355.2 7369.7 1957.9 2008.5 2034.1 2042.4 2044.9 890.5 895.9 902.2 908.5 922.8 19700.7 20186.8 20258.3 20584.0 20585.8 930.8 934.3 936.4 939.8 944.1 10981.8 11377.7 11456.3 12686.7 12760.3 664655.0 670322.0 676179.0 693051.0 695007.0 74882.3 79488.0 80725.2 110149.0 112916.0 1086.6 1140.1 1152.1 1153.2 1175.1 18482.7 18597.6 19413.4 19432.4 19441.4 44821.0 45534.3 45792.3 46293.8 47416.2 64081.7 64116.7 64511.9 65205.0 65432.7 8706.6 8797.5 9151.2 9166.1 9273.3 8349.5 12270.8 13692.8 14003.3 14080.2 10827.9 11406.7 11448.6 11726.8 11955.2 11537.8 11692.2 11853.3 12062.4 12088.6 10799.5 11927.9 11969.8 12262.1 12279.4 7935.1 8274.5 8606.0 8733.7 8740.8 10689.7 12111.9 12294.9 12379.4 12547.3 17:02:57 INFO - PROCESS | 10140 | 17:02:57 INFO - PROCESS | 10140 | [#3] mootools.html Cycles:180 Average:5434.15 Median:5208.61 stddev:2928.02 (56.2%) stddev-sans-first:2920.71 17:02:57 INFO - PROCESS | 10140 | Values: 1422.2 1426.6 1437.3 1456.6 1461.5 7739.5 8114.5 8225.8 8229.8 8242.3 7121.3 7273.0 7812.1 8030.0 8128.2 2373.4 2400.4 2409.9 2414.1 2414.7 2230.0 2307.0 2308.8 2313.1 2313.3 2042.6 2100.8 2296.6 2346.2 2351.6 2279.0 2299.9 2318.6 2320.9 2321.8 2337.7 2345.9 2366.6 2369.8 2371.3 8228.5 8287.8 8291.8 8296.6 8297.2 5071.1 5208.3 5208.9 5209.7 5211.2 3126.5 3234.4 3347.5 3350.3 3416.3 1355.9 1370.7 1414.7 1415.0 1468.8 11154.0 11208.2 11218.0 11218.2 11226.1 4329.2 4602.8 4663.2 4690.2 4740.5 9591.2 9611.2 9628.8 9642.6 9647.4 5248.4 5272.0 5279.8 5282.6 5283.7 4798.6 4819.8 4856.0 4857.2 4867.7 3833.9 3913.7 3955.6 4012.7 4115.8 1172.8 1281.2 1292.8 1293.5 1305.8 808.4 930.5 939.1 947.2 986.4 5153.8 5291.9 5308.1 5372.3 5409.7 1030.2 1035.9 1048.0 1058.5 1084.3 3519.9 3578.6 3594.1 3595.0 3629.7 9647.9 9997.5 10003.2 10003.4 10025.8 9908.8 9911.5 9917.3 9920.5 9924.5 7325.8 7544.4 7603.8 7753.0 7794.1 5554.5 5693.7 5720.4 5825.5 5871.9 8540.7 8744.9 8981.1 9067.0 9067.2 8825.9 8987.1 9072.1 9089.6 9135.4 7178.9 7270.2 7305.9 7326.3 7331.4 7823.3 7844.5 7887.3 7891.3 7917.1 7099.3 7162.9 7183.5 7221.7 7375.0 7040.1 7096.9 7113.3 7122.8 7143.6 6321.4 6337.9 6362.4 6407.1 6425.6 4872.7 4919.9 4921.6 4926.1 5014.9 5018.5 5140.4 5183.4 5189.5 5190.1 17:02:57 INFO - PROCESS | 10140 | 17:02:57 INFO - PROCESS | 10140 | [#4] prototype.html Cycles:180 Average:4665.73 Median:5242.42 stddev:1338.21 (25.5%) stddev-sans-first:1302.85 17:02:57 INFO - PROCESS | 10140 | Values: 386.3 404.0 410.5 412.8 416.6 5262.5 5299.8 5312.4 5318.8 5358.1 5200.5 5258.3 5301.6 5306.0 5306.9 3843.8 4150.4 4163.7 4168.9 4187.7 4164.4 4167.2 4186.7 4188.4 4194.5 4161.9 4172.2 4178.6 4189.7 4209.4 3883.0 4002.4 4078.4 4189.5 4194.6 3601.2 3603.8 3605.9 3606.6 3611.0 5144.4 5150.5 5159.2 5166.2 5195.6 4578.4 4710.2 4729.3 4758.9 4760.8 5512.8 5517.5 5521.3 5551.5 5556.9 3993.8 4003.3 4008.3 4011.7 4051.9 5134.5 5556.7 5589.9 5809.0 5810.9 4106.7 4107.5 4114.7 4139.0 4145.6 4176.7 4179.1 4182.4 4202.8 4207.5 4521.3 4637.7 4734.1 4756.3 4756.6 5506.5 5545.8 5591.4 5594.7 5597.4 1477.6 1486.9 1488.2 1505.5 1507.9 1028.7 1090.2 1094.4 1102.4 1107.7 5144.0 5192.3 5233.0 5251.8 5258.4 5491.0 5495.3 5519.0 5522.8 5579.7 4903.4 5174.3 5177.3 5189.2 5194.8 2927.3 2947.8 2948.5 2954.6 2954.9 5725.3 5762.2 5770.5 5771.5 5776.5 5452.1 5537.9 5833.2 5848.4 5852.9 5741.7 5809.3 5885.9 5904.0 5910.4 5701.5 5707.1 5743.1 5752.8 5761.4 5519.3 5594.6 5601.2 5602.7 5627.4 5878.0 5893.6 5893.7 5895.0 5906.4 4116.2 4130.9 4152.6 4153.9 4158.0 5528.4 5655.6 5661.4 5694.5 5707.2 5531.3 5535.2 5557.0 5565.0 5582.7 5365.7 5512.8 5585.2 5596.6 5602.3 5537.4 5538.9 5551.8 5552.8 5553.3 5556.9 5567.6 5572.0 5582.9 5591.3 5185.4 5385.3 5392.4 5400.6 5416.7 17:02:57 INFO - PROCESS | 10140 | 17:02:57 INFO - PROCESS | 10140 | [#5] yui.html Cycles:180 Average:17066.48 Median:4333.54 stddev:21207.57 (489.4%) stddev-sans-first:21231.66 17:02:57 INFO - PROCESS | 10140 | Values: 749.3 789.8 792.0 848.3 857.2 15535.4 16579.8 16695.1 16964.7 16987.4 13781.8 13887.9 13909.8 13915.7 13917.4 635.4 642.7 728.3 734.7 738.8 739.2 745.7 746.1 746.4 747.0 793.6 793.8 794.2 794.4 795.0 675.2 683.4 759.1 788.7 790.1 567.7 580.3 580.4 580.5 580.8 15716.1 16270.3 16279.1 16293.2 16300.4 14403.7 14594.5 14961.6 15053.1 15209.4 11927.7 11933.0 13439.0 13557.2 13644.1 4501.0 4576.2 4794.0 4801.5 4804.3 75021.0 75669.0 75794.0 76473.6 77580.6 10488.5 10502.4 10878.8 10937.7 10947.1 19810.9 20181.2 20186.9 20343.2 20389.7 7485.3 7551.7 7656.9 7717.0 7729.1 4323.7 4343.4 4354.3 4385.2 4476.1 3518.4 3608.4 3614.6 3616.5 3872.1 684.0 692.8 697.3 700.6 708.9 753.7 761.4 779.8 795.4 806.9 10576.2 10597.9 10789.9 10802.7 10923.6 729.0 764.9 781.9 783.1 795.2 4765.4 5078.3 5143.4 5147.5 5149.7 76324.6 77143.9 79581.6 79993.0 81386.0 50729.2 52528.5 69356.0 70080.3 70153.3 56056.4 56093.2 56956.6 57152.0 58520.4 10496.3 10709.6 10784.1 10880.2 11175.1 35927.3 40062.0 41333.6 41735.8 42295.0 47868.3 49330.3 49464.3 50274.0 52287.0 12852.0 12957.2 12979.7 12986.5 13251.7 14126.2 14681.6 14686.2 15057.2 15289.8 13617.3 14009.0 14050.6 14081.8 14096.2 13692.9 13699.9 14130.1 14383.5 14496.6 13605.2 13692.9 14067.6 14153.6 14247.6 10102.6 10166.5 10244.9 10388.3 10629.8 10681.3 10758.4 10798.2 10940.4 10986.8 17:02:57 INFO - PROCESS | 10140 | -------- Summary: end -------- 17:02:57 INFO - PROCESS | 10140 | 17:02:58 INFO - TEST-INFO | 10140: exit 0 17:02:58 INFO - TEST-OK | dromaeo_css | took 1115634ms 17:02:58 INFO - TEST-START | kraken 17:02:58 INFO - operating with platform_type : linux_ 17:02:58 INFO - Initialising browser for kraken test... 17:02:58 INFO - TEST-INFO | started process 10443 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzFUkBU/profile http://localhost:36480/getInfo.html) 17:03:01 INFO - PROCESS | 10443 | __metrics Screen width/height:1600/1200 17:03:01 INFO - PROCESS | 10443 | colorDepth:24 17:03:01 INFO - PROCESS | 10443 | Browser inner width/height: 1024/697 17:03:01 INFO - PROCESS | 10443 | __metrics 17:03:02 INFO - PROCESS | 10443 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:03:02 INFO - PROCESS | 10443 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:03:03 INFO - PROCESS | 10443 | console.error: PushService: 17:03:03 INFO - PROCESS | 10443 | stateChangeProcessEnqueue: Error transitioning state 17:03:03 INFO - PROCESS | 10443 | UnknownError 17:03:03 INFO - TEST-INFO | 10443: exit 0 17:03:03 INFO - Browser initialized. 17:03:03 INFO - Running cycle 1/1 for kraken test... 17:03:03 INFO - TEST-INFO | started process 10529 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzFUkBU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:03:15 INFO - PROCESS | 10529 | RSS: Main: 147689472 17:03:15 INFO - PROCESS | 10529 | 17:03:18 INFO - PROCESS | 10529 | Cycle 1(1): loaded http://localhost:36480/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36480/tests/kraken/driver.html?testName=audio-beat-detection) 17:03:18 INFO - PROCESS | 10529 | RSS: Main: 202665984 17:03:18 INFO - PROCESS | 10529 | 17:03:21 INFO - PROCESS | 10529 | Cycle 1(1): loaded http://localhost:36480/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36480/tests/kraken/driver.html?testName=audio-dft) 17:03:22 INFO - PROCESS | 10529 | RSS: Main: 181129216 17:03:22 INFO - PROCESS | 10529 | 17:03:25 INFO - PROCESS | 10529 | Cycle 1(1): loaded http://localhost:36480/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36480/tests/kraken/driver.html?testName=audio-fft) 17:03:25 INFO - PROCESS | 10529 | RSS: Main: 263716864 17:03:25 INFO - PROCESS | 10529 | 17:03:27 INFO - PROCESS | 10529 | Cycle 1(1): loaded http://localhost:36480/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36480/tests/kraken/driver.html?testName=audio-oscillator) 17:03:28 INFO - PROCESS | 10529 | RSS: Main: 174309376 17:03:28 INFO - PROCESS | 10529 | 17:03:30 INFO - PROCESS | 10529 | Cycle 1(1): loaded http://localhost:36480/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36480/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:03:31 INFO - PROCESS | 10529 | RSS: Main: 178708480 17:03:31 INFO - PROCESS | 10529 | 17:03:34 INFO - PROCESS | 10529 | Cycle 1(1): loaded http://localhost:36480/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36480/tests/kraken/driver.html?testName=imaging-darkroom) 17:03:34 INFO - PROCESS | 10529 | RSS: Main: 218066944 17:03:34 INFO - PROCESS | 10529 | 17:03:38 INFO - PROCESS | 10529 | Cycle 1(1): loaded http://localhost:36480/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36480/tests/kraken/driver.html?testName=imaging-desaturate) 17:03:38 INFO - PROCESS | 10529 | RSS: Main: 218681344 17:03:38 INFO - PROCESS | 10529 | 17:03:41 INFO - PROCESS | 10529 | Cycle 1(1): loaded http://localhost:36480/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36480/tests/kraken/driver.html?testName=json-parse-financial) 17:03:42 INFO - PROCESS | 10529 | RSS: Main: 216522752 17:03:42 INFO - PROCESS | 10529 | 17:03:43 INFO - PROCESS | 10529 | Cycle 1(1): loaded http://localhost:36480/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36480/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:03:44 INFO - PROCESS | 10529 | RSS: Main: 179036160 17:03:44 INFO - PROCESS | 10529 | 17:03:46 INFO - PROCESS | 10529 | Cycle 1(1): loaded http://localhost:36480/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36480/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:03:46 INFO - PROCESS | 10529 | RSS: Main: 186179584 17:03:46 INFO - PROCESS | 10529 | 17:03:48 INFO - PROCESS | 10529 | Cycle 1(1): loaded http://localhost:36480/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36480/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:03:49 INFO - PROCESS | 10529 | RSS: Main: 195125248 17:03:49 INFO - PROCESS | 10529 | 17:03:51 INFO - PROCESS | 10529 | Cycle 1(1): loaded http://localhost:36480/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36480/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:03:52 INFO - PROCESS | 10529 | RSS: Main: 204148736 17:03:52 INFO - PROCESS | 10529 | 17:03:55 INFO - PROCESS | 10529 | Cycle 1(1): loaded http://localhost:36480/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36480/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:03:56 INFO - PROCESS | 10529 | RSS: Main: 201007104 17:03:56 INFO - PROCESS | 10529 | 17:03:57 INFO - PROCESS | 10529 | Cycle 1(1): loaded http://localhost:36480/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36480/tests/kraken/driver.html?testName=ai-astar) 17:03:57 INFO - PROCESS | 10529 | RSS: Main: 249765888 17:03:57 INFO - PROCESS | 10529 | 17:03:57 INFO - PROCESS | 10529 | __start_tp_report 17:03:57 INFO - PROCESS | 10529 | _x_x_mozilla_page_load 17:03:57 INFO - PROCESS | 10529 | _x_x_mozilla_page_load_details 17:03:57 INFO - PROCESS | 10529 | |i|pagename|runs| 17:03:57 INFO - PROCESS | 10529 | |0;ai-astar;110;113;111;111;110;113;111;112;111;111 17:03:57 INFO - PROCESS | 10529 | |1;audio-beat-detection;150;118;118;170;122;118;120;118;153;124 17:03:57 INFO - PROCESS | 10529 | |2;audio-dft;161;161;162;162;161;162;171;161;161;161 17:03:57 INFO - PROCESS | 10529 | |3;audio-fft;75;75;75;121;77;75;75;76;90;76 17:03:57 INFO - PROCESS | 10529 | |4;audio-oscillator;83;84;104;82;84;84;95;84;83;107 17:03:57 INFO - PROCESS | 10529 | |5;imaging-gaussian-blur;117;116;117;118;117;116;117;118;117;117 17:03:57 INFO - PROCESS | 10529 | |6;imaging-darkroom;146;146;146;146;147;146;148;146;148;147 17:03:57 INFO - PROCESS | 10529 | |7;imaging-desaturate;97;96;96;96;96;96;97;96;96;96 17:03:57 INFO - PROCESS | 10529 | |8;json-parse-financial;51;50;51;50;51;52;52;51;52;51 17:03:57 INFO - PROCESS | 10529 | |9;json-stringify-tinderbox;67;67;67;67;67;66;66;68;68;68 17:03:57 INFO - PROCESS | 10529 | |10;stanford-crypto-aes;83;83;83;85;83;85;92;90;92;83 17:03:57 INFO - PROCESS | 10529 | |11;stanford-crypto-ccm;137;142;126;129;125;135;130;125;161;125 17:03:57 INFO - PROCESS | 10529 | |12;stanford-crypto-pbkdf2;171;173;172;170;169;174;170;171;169;173 17:03:57 INFO - PROCESS | 10529 | |13;stanford-crypto-sha256-iterative;63;63;62;62;63;63;69;61;61;61 17:03:57 INFO - PROCESS | 10529 | __end_tp_report 17:03:57 INFO - PROCESS | 10529 | __start_cc_report 17:03:57 INFO - PROCESS | 10529 | _x_x_mozilla_cycle_collect,1544 17:03:57 INFO - PROCESS | 10529 | __end_cc_report 17:03:57 INFO - PROCESS | 10529 | __startTimestamp1484355837976__endTimestamp 17:03:57 INFO - PROCESS | 10529 | 17:03:57 INFO - PROCESS | 10529 | ------- Summary: start ------- 17:03:57 INFO - PROCESS | 10529 | Number of tests: 14 17:03:57 INFO - PROCESS | 10529 | 17:03:57 INFO - PROCESS | 10529 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:1.06 (1.0%) stddev-sans-first:1.01 17:03:57 INFO - PROCESS | 10529 | Values: 110.0 113.0 111.0 111.0 110.0 113.0 111.0 112.0 111.0 111.0 17:03:57 INFO - PROCESS | 10529 | 17:03:57 INFO - PROCESS | 10529 | [#1] audio-beat-detection Cycles:10 Average:131.10 Median:123.00 stddev:19.13 (15.6%) stddev-sans-first:19.03 17:03:57 INFO - PROCESS | 10529 | Values: 150.0 118.0 118.0 170.0 122.0 118.0 120.0 118.0 153.0 124.0 17:03:57 INFO - PROCESS | 10529 | 17:03:57 INFO - PROCESS | 10529 | [#2] audio-dft Cycles:10 Average:162.30 Median:161.50 stddev:3.09 (1.9%) stddev-sans-first:3.24 17:03:57 INFO - PROCESS | 10529 | Values: 161.0 161.0 162.0 162.0 161.0 162.0 171.0 161.0 161.0 161.0 17:03:57 INFO - PROCESS | 10529 | 17:03:57 INFO - PROCESS | 10529 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.50 stddev:14.62 (19.4%) stddev-sans-first:15.32 17:03:57 INFO - PROCESS | 10529 | Values: 75.0 75.0 75.0 121.0 77.0 75.0 75.0 76.0 90.0 76.0 17:03:57 INFO - PROCESS | 10529 | 17:03:57 INFO - PROCESS | 10529 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:84.00 stddev:9.46 (11.3%) stddev-sans-first:9.79 17:03:57 INFO - PROCESS | 10529 | Values: 83.0 84.0 104.0 82.0 84.0 84.0 95.0 84.0 83.0 107.0 17:03:57 INFO - PROCESS | 10529 | 17:03:57 INFO - PROCESS | 10529 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 17:03:57 INFO - PROCESS | 10529 | Values: 117.0 116.0 117.0 118.0 117.0 116.0 117.0 118.0 117.0 117.0 17:03:57 INFO - PROCESS | 10529 | 17:03:57 INFO - PROCESS | 10529 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 17:03:57 INFO - PROCESS | 10529 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 148.0 146.0 148.0 147.0 17:03:57 INFO - PROCESS | 10529 | 17:03:57 INFO - PROCESS | 10529 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 17:03:57 INFO - PROCESS | 10529 | Values: 97.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 17:03:57 INFO - PROCESS | 10529 | 17:03:57 INFO - PROCESS | 10529 | [#8] json-parse-financial Cycles:10 Average:51.10 Median:51.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 17:03:57 INFO - PROCESS | 10529 | Values: 51.0 50.0 51.0 50.0 51.0 52.0 52.0 51.0 52.0 51.0 17:03:57 INFO - PROCESS | 10529 | 17:03:57 INFO - PROCESS | 10529 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 17:03:57 INFO - PROCESS | 10529 | Values: 67.0 67.0 67.0 67.0 67.0 66.0 66.0 68.0 68.0 68.0 17:03:57 INFO - PROCESS | 10529 | 17:03:57 INFO - PROCESS | 10529 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:85.00 stddev:3.87 (4.6%) stddev-sans-first:3.96 17:03:57 INFO - PROCESS | 10529 | Values: 83.0 83.0 83.0 85.0 83.0 85.0 92.0 90.0 92.0 83.0 17:03:57 INFO - PROCESS | 10529 | 17:03:57 INFO - PROCESS | 10529 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:132.50 stddev:11.30 (8.5%) stddev-sans-first:11.91 17:03:57 INFO - PROCESS | 10529 | Values: 137.0 142.0 126.0 129.0 125.0 135.0 130.0 125.0 161.0 125.0 17:03:57 INFO - PROCESS | 10529 | 17:03:57 INFO - PROCESS | 10529 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.20 Median:171.50 stddev:1.75 (1.0%) stddev-sans-first:1.86 17:03:57 INFO - PROCESS | 10529 | Values: 171.0 173.0 172.0 170.0 169.0 174.0 170.0 171.0 169.0 173.0 17:03:57 INFO - PROCESS | 10529 | 17:03:57 INFO - PROCESS | 10529 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:2.35 (3.7%) stddev-sans-first:2.49 17:03:57 INFO - PROCESS | 10529 | Values: 63.0 63.0 62.0 62.0 63.0 63.0 69.0 61.0 61.0 61.0 17:03:57 INFO - PROCESS | 10529 | -------- Summary: end -------- 17:03:57 INFO - PROCESS | 10529 | 17:03:58 INFO - TEST-INFO | 10529: exit 0 17:03:59 INFO - TEST-OK | kraken | took 60751ms 17:03:59 INFO - SUITE-END | took 1176s 17:03:59 INFO - Completed test suite (00:19:36) 17:03:59 INFO - javascript benchmark 17:03:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3165.7150856422923, 3235.0780027692113, 3270.149761062124, 3272.0347497488237, 3274.6889045540697, 5388.245645609618, 5420.0, 5476.452354764521, 5519.392866784656, 5567.777288908444, 5482.616216864821, 5490.478404551571, 5534.778608855641, 5567.693776842272, 5619.044762390393, 4898.093852637265, 4913.778879950393, 4937.407511098673, 4951.430585482662, 5008.524190201943, 5009.749512524378, 5028.522290382408, 5029.321041659366, 5040.621953353495, 5042.445331013586, 4780.163471392492, 4839.201531747258, 4932.728699921503, 4950.034743225073, 5041.59667226621, 4885.047415753929, 4932.654714170009, 4943.134951383529, 4944.975275123637, 5023.7236951967625, 4888.780004899752, 4898.289747986558, 4905.656604037718, 4916.901661966776, 4935.407751069859, 5374.731263436852, 5553.7778488860395, 5556.0, 5558.666480011212, 5562.0, 5832.387599302055, 5850.970745146247, 5861.4724674779045, 5876.4123587641325, 6012.6392416455155, 5986.640801551921, 6000.699965001732, 6008.729607167688, 6010.75956961721, 6012.639241645472, 5563.082091454905, 5570.693611851306, 5574.052411090165, 5578.63738856973, 5586.162075688598, 5944.791932282349, 5971.611845230133, 6009.909851352233, 6010.699465026732, 6017.909731354033, 5763.423657634287, 5802.738876750556, 5803.88392232153, 5814.0, 5858.443447872445, 5742.483176514133, 5793.478586927113, 5848.736806843703, 5900.0, 5913.9112913306335, 5859.355470898283, 5891.587588868738, 5930.021546444788, 6021.5182785377065, 6023.548233882477, 5925.318588362307, 5967.76128954837, 5989.041753319448, 6000.0, 6008.729607167688, 4627.838025669085, 4629.560191781776, 4630.83792067276, 4633.652476064309, 4671.95328046722, 4080.265552200573, 4110.034141976633, 4112.814923328458, 4116.094459218967, 4183.769892655872, 5594.748236329375, 5633.295838020247, 5638.295213098363, 5683.744231509592, 5744.023516002289, 5928.436798504135, 5947.672877991666, 5986.431289027535, 5987.940120598825, 6001.729922153513, 5412.458754124556, 5676.858078547987, 5684.687342196219, 5685.459881311269, 5698.943010569841, 4947.282644016597, 5129.333186685707, 5197.220416937414, 5206.73966301691, 5208.166693329049, 6275.0, 6276.089966954766, 6281.403266689748, 6286.15136956505, 6286.5599408041, 6028.0, 6033.0, 6037.969810150921, 6041.426064523863, 6043.244594425697, 5946.672932988728, 6012.579119461596, 6058.242719660043, 6060.151578779062, 6091.725872335667, 5779.162021506942, 5826.621269617462, 5843.1235314703135, 5862.413758624103, 5876.147958546072, 5878.2358293421585, 5960.5827592068135, 5967.552433567413, 5983.0, 5985.581009329305, 5680.375158732453, 5748.223989761329, 5814.331351894586, 5818.0, 5835.620684655653, 5895.322037965689, 5900.380460051632, 5905.35041145465, 5907.586468947305, 5964.761409543569, 5882.411758824083, 5897.351291357862, 5904.409559044061, 5909.349971503045, 5909.409059094228, 5649.039663257174, 5702.429757024431, 5702.45826646468, 5739.282589676291, 5835.387284335084, 5668.348139963957, 5712.514436272797, 5720.342160651412, 5753.0, 5764.337101233412], "value": 5469.382215626814, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.8504603756985, 566.8214512428584, 577.8873119741651, 595.8718875441779, 596.9821454420214, 34350.65649343506, 44548.33177502336, 45865.0, 46321.30518042232, 50157.74921125389, 46969.53030469694, 47202.0, 47339.52660473394, 47341.52658473414, 47353.52646473534, 8905.109489051092, 9067.773305667346, 9090.681826136086, 9091.318151138657, 9107.180353768159, 8639.39524233304, 8847.690330838423, 10718.571257149704, 10940.890591094067, 10944.945275273612, 10905.400202988832, 10963.890361096366, 10964.396958167337, 10967.451627418637, 10972.177086718488, 10796.730081747979, 10826.783464330669, 10841.506453515696, 10869.782604347869, 10872.782544349147, 10687.893121068846, 10764.24650274481, 10766.40784756838, 10767.676969690921, 10770.138388928866, 42393.1521369574, 42581.78709106435, 42712.145757084996, 42715.0, 42755.57244427547, 4177.310743727312, 4218.535961044283, 4234.026937496272, 4244.469441319835, 4286.721363111388, 31599.52600710991, 33193.3361332772, 33369.83315083433, 33377.6662233377, 33393.6660633393, 4292.871213863589, 4336.544662810391, 4413.801378937956, 4570.497245303014, 4577.404937358122, 320513.0, 321093.0, 321823.0, 321961.0, 322117.0, 61691.38308616946, 61736.38263617396, 62097.0, 62225.68887155626, 62230.0, 64333.67833160804, 64490.0, 64541.0, 64664.0, 64664.67667661726, 15919.920400398156, 16057.23370429252, 16088.276027578788, 16131.354745810271, 16134.515964521082, 10435.113015393777, 10720.088792452729, 12288.262704237774, 12361.381930903419, 12362.814557781641, 17549.210285536927, 17870.91064544669, 17880.0, 18293.176807043714, 18428.539286517676, 6948.652567371712, 7006.859862802716, 7059.541129826544, 7120.786376408716, 7252.311030452099, 940.1303793990531, 950.254050570299, 953.8950715421298, 962.9903700962901, 971.1065819446127, 30652.846735766623, 32549.51175732366, 32704.509432358533, 32875.50686739701, 33032.66967330344, 1037.7976294622626, 1133.7052366384798, 1146.529922731676, 1162.2793867802018, 1171.6133675886938, 16050.919745401432, 17169.48491545256, 17445.0, 17489.98997751181, 17575.0, 436432.0, 436434.0, 442620.0, 443418.0, 444522.0, 61865.69067154726, 61910.38089619136, 61988.69005654943, 62428.375716243165, 62540.06189907155, 1452.4771082410323, 1485.3909896941987, 1491.2767307855681, 1492.8133983252094, 1501.992490037543, 30169.849150754984, 31784.68215317817, 32044.679553205104, 32285.838570806995, 32646.83676581697, 52714.73642631762, 53655.731721341144, 53693.73153134209, 53738.0, 53811.461885380646, 372818.0, 373777.0, 373988.0, 374001.0, 374753.0, 24520.14179503709, 25183.37041573975, 41898.79050604849, 42099.158016838875, 42165.78917105395, 38979.610203897595, 39815.60184398119, 43603.56396435995, 44323.556764431945, 45181.0, 35733.46399803953, 38894.222115556964, 39072.02319942024, 40624.79687601543, 40820.0, 37655.82175538744, 38255.23489530249, 38778.61221387863, 39465.40801887916, 40103.39844902387, 38589.80705096456, 39530.2093958125, 39537.0, 39635.0, 39815.80092099521, 32643.673563265012, 33156.50265246072, 33823.83088084544, 34404.655953440146, 34811.825940870134, 26398.472030558896, 26423.471530568895, 26507.072252471073, 26620.866895665396, 26660.333491662088], "value": 20402.431097113964, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.8695304455617, 421.83126749300277, 424.77699207915833, 428.6206707064248, 439.27519592672087, 19937.900310498462, 20624.0, 21074.789252107512, 21214.89392553039, 21364.4658883528, 19239.61520769584, 20027.89986050068, 20330.186792528282, 20748.688769668468, 20845.27041553546, 5786.508146807527, 5999.970000149993, 6034.24571928509, 6040.187943616919, 6045.637261764286, 5797.942020579803, 5908.9409105909035, 5964.1650168976375, 6006.909896351558, 6009.338972712998, 5978.8804223915495, 5986.850328741794, 5992.370801065891, 5992.7303271352675, 6001.639901605896, 5751.281089863767, 5851.707414629294, 5864.677442740647, 5905.822825315247, 5968.462838344548, 5228.424873263976, 5247.134222853225, 5308.283381743454, 5315.867103322409, 5321.281626980347, 23403.648945265835, 24776.3805904852, 24844.875775621007, 25039.87480062606, 25132.874335628207, 2802.2714094335415, 2806.7052959439375, 2816.8732407041734, 2820.1680504251294, 2821.858907054639, 14627.488037918622, 15368.462103826425, 15596.220188990505, 15805.130717810516, 16295.0, 1918.2039453626728, 1947.260041184341, 1950.0639692947464, 1965.7346258255095, 2010.5174758058106, 89176.55411722965, 90232.0, 91901.99999999933, 92527.0, 93203.0, 11325.660230193107, 11537.538498459968, 11696.70758231034, 11767.705807354885, 11826.11304152192, 16427.342906283615, 16449.6710065798, 16450.83549164493, 16454.0, 16486.83513164877, 8184.427090103635, 8332.833343333099, 8364.58177091143, 8491.74524764258, 8602.354823388147, 7807.882881756778, 7875.763727088197, 7950.204979502119, 8124.390670699721, 8151.470154439942, 7141.464390170758, 7188.209296977328, 7261.273872612802, 7355.1541572719825, 7369.668364923591, 1957.9216831326587, 2008.5380362516703, 2034.0948278016438, 2042.428120126367, 2044.8977551122384, 890.5191196753681, 895.9372843900865, 902.2195800632537, 908.5457271364318, 922.8062106957614, 19700.70448943267, 20186.79813201849, 20258.29095981663, 20584.0, 20585.838486958954, 930.7719608695777, 934.2619330728648, 936.3913456253354, 939.8167357365248, 944.1313991128178, 10981.780364392667, 11377.658670239905, 11456.312621242752, 12686.682832929251, 12760.29818359999, 664655.0, 670322.0, 676179.0, 693051.0, 695007.0, 74882.25117748862, 79487.99999999885, 80725.19274807294, 110149.0, 112916.0, 1086.5979587552497, 1140.0822338017974, 1152.1474109159162, 1153.1754795321385, 1175.0540814644294, 18482.722759158893, 18597.628047438706, 19413.4175974721, 19432.4170274892, 19441.416757497296, 44821.0, 45534.316985244586, 45792.31311530263, 46293.768531157126, 47416.20670346433, 64081.67959160174, 64116.679416604486, 64511.87137221956, 65205.0, 65432.67283663551, 8706.56467176626, 8797.47215167092, 9151.222146117654, 9166.129217724305, 9273.30450216223, 8349.457285276438, 12270.754584908073, 13692.794608080687, 14003.299835008005, 14080.22558759278, 10827.945860270649, 11406.657800266004, 11448.599299024494, 11726.765464690488, 11955.163138580563, 11537.82693259585, 11692.181547291608, 11853.34806585646, 12062.396880156133, 12088.576899808464, 10799.514021869192, 11927.940360298144, 11969.820452693391, 12262.08034397406, 12279.386030698251, 7935.0874649416055, 8274.503529788231, 8606.0, 8733.694320698745, 8740.78148046304, 10689.732756681145, 12111.878881211427, 12294.87705122973, 12379.381030948236, 12547.3098979557], "value": 9882.64434737815, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1422.1751384197166, 1426.61481400022, 1437.3172742947095, 1456.6067161866295, 1461.5469204546594, 7739.496932699378, 8114.472559283649, 8225.794355141124, 8229.753107406787, 8242.340612750973, 7121.2878712128895, 7272.96363518183, 7812.101608315045, 8029.959850200756, 8128.187181281884, 2373.359193017884, 2400.435897564071, 2409.855408675476, 2414.14297924237, 2414.6860908081926, 2230.0, 2307.042577330406, 2308.8152947764224, 2313.1094528606523, 2313.2597568777996, 2042.6221149087467, 2100.789921007902, 2296.5980953333183, 2346.2022912209845, 2351.6119840226343, 2279.0, 2299.8850057497143, 2318.6174281243575, 2320.9071637134493, 2321.7562155973546, 2337.6960995070704, 2345.8944347504234, 2366.5740166769974, 2369.774871387233, 2371.253055287596, 8228.547429891354, 8287.751367458986, 8291.792705182359, 8296.626651800683, 8297.170282971714, 5071.112555302807, 5208.322918020633, 5208.8958220835375, 5209.6874187548865, 5211.24436956643, 3126.452870747633, 3234.4313008191007, 3347.5146103815055, 3350.2964377480757, 3416.3167366526795, 1355.9050866439354, 1370.7327071221116, 1414.7453458377488, 1414.9575512734634, 1468.8090548228663, 11154.0, 11208.21542492026, 11218.046466050313, 11218.214724969173, 11226.101911847032, 4329.15581461612, 4602.7698615069785, 4663.230566956414, 4690.15577196108, 4740.454847692559, 9591.184749296248, 9611.231101511863, 9628.807423851484, 9642.566084526074, 9647.421154730739, 5248.396434410091, 5271.973640131851, 5279.815206467755, 5282.550983166474, 5283.682979021271, 4798.616110711135, 4819.783109760069, 4856.028794241166, 4857.198562237191, 4867.70793752376, 3833.923321533554, 3913.68891421377, 3955.64399204073, 4012.7391719538136, 4115.835366585363, 1172.8006238939402, 1281.1608396500308, 1292.7866901961258, 1293.4567481657725, 1305.8117113426736, 808.4340961327094, 930.5161316115582, 939.0703203828161, 947.2374738335568, 986.40815510693, 5153.819616313411, 5291.894162116736, 5308.097623404031, 5372.301600791872, 5409.7295135243085, 1030.1861529391697, 1035.880873699519, 1047.9947600262103, 1058.523664351045, 1084.2789544952518, 3519.9296014079573, 3578.624244454295, 3594.101474631342, 3594.98202508991, 3629.709623230188, 9647.9035209647, 9997.450140242356, 10003.24975626831, 10003.44981026036, 10025.849612255823, 9908.80182396348, 9911.45486998222, 9917.256205784595, 9920.454375009444, 9924.454155021544, 7325.7802265932105, 7544.358729508053, 7603.809904752426, 7753.0, 7794.103678077094, 5554.50009499147, 5693.658380497018, 5720.3707592165665, 5825.475707186373, 5871.882562348644, 8540.70107546233, 8744.868826967728, 8981.056989016059, 9067.0, 9067.183953444222, 8825.91174088251, 8987.146221108984, 9072.138146876036, 9089.59096840657, 9135.40619859707, 7178.892316615359, 7270.236625154283, 7305.853882922205, 7326.3040011198855, 7331.3768329692575, 7823.2567906048835, 7844.529328240324, 7887.3295769857905, 7891.250331218525, 7917.089534703583, 7099.325564071405, 7162.89255661155, 7183.5330703504105, 7221.747238846615, 7374.963125184339, 7040.084788977605, 7096.858062838817, 7113.253108423541, 7122.821929451805, 7143.642817858982, 6321.399467050623, 6337.873242535031, 6362.395572420613, 6407.103005579316, 6425.614463132227, 4872.6832755870755, 4919.926201107058, 4921.630877684116, 4926.103450171638, 5014.899702006012, 5018.4981501849525, 5140.3831540215415, 5183.352080989876, 5189.506996835295, 5190.091733946469], "value": 4455.529006368191, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.327789646016, 403.98586049488273, 410.5073911306432, 412.83899279281064, 416.5979829464566, 5262.5263726264675, 5299.761510732017, 5312.389075256347, 5318.78724851006, 5358.142697168454, 5200.453952335007, 5258.342707161605, 5301.602379821519, 5306.0, 5306.893862122755, 3843.846246150151, 4150.3774433835015, 4163.7293575917465, 4168.916621667565, 4187.685923555746, 4164.437800896871, 4167.187398457302, 4186.74879507229, 4188.350805625118, 4194.517630472489, 4161.854335098272, 4172.165566886635, 4178.582141785828, 4189.748615083089, 4209.4317267169, 3883.0, 4002.419649150857, 4078.4290199372113, 4189.476315460567, 4194.601512856289, 3601.243738814852, 3603.765755225902, 3605.8737944171826, 3606.5852426970973, 3610.981945090284, 5144.4083930348115, 5150.459201783796, 5159.22611608258, 5166.173412254021, 5195.558377537914, 4578.381918441034, 4710.222813235812, 4729.304296550968, 4758.928616070762, 4760.7619619018915, 5512.80705175317, 5517.475839795253, 5521.309836270466, 5551.528120109755, 5556.91664625031, 3993.7803420811842, 4003.2994226010624, 4008.2584721826265, 4011.65900898424, 4051.9392209116886, 5134.486551344873, 5556.722163891789, 5589.931725261598, 5808.97095514524, 5810.912836307459, 4106.650934670586, 4107.466029416157, 4114.691398145151, 4138.958610413918, 4145.647619952338, 4176.6843444315555, 4179.12238429927, 4182.414461975326, 4202.810873510638, 4207.5161356444405, 4521.276595744731, 4637.721736695809, 4734.130018642686, 4756.286557016475, 4756.6432517561325, 5506.504414602705, 5545.750441230073, 5591.3569939456665, 5594.720263986785, 5597.440255974451, 1477.5567329801017, 1486.869978816086, 1488.159190057614, 1505.4655597263034, 1507.947221847252, 1028.7428142964259, 1090.1987039525943, 1094.3762055628374, 1102.399192440122, 1107.7175320293434, 5143.968132587682, 5192.273081768555, 5233.031889100528, 5251.8161864335325, 5258.39528454225, 5491.0, 5495.258140151109, 5518.972405138029, 5522.784987302787, 5579.69311687861, 4903.362562866804, 5174.275601415805, 5177.301064356264, 5189.247559103909, 5194.84415467529, 2927.253550344691, 2947.8208716513136, 2948.469275530425, 2954.6454425469083, 2954.8670309836107, 5725.31296244445, 5762.222100016528, 5770.480656740913, 5771.547092485677, 5776.480116789509, 5452.064517096453, 5537.861553461115, 5833.212516310244, 5848.356680765112, 5852.94147058524, 5741.741621627037, 5809.302883653989, 5885.882282354329, 5903.970480147744, 5910.408959104056, 5701.515371193329, 5707.1153971134545, 5743.10981797822, 5752.769889204553, 5761.39505351932, 5519.337679478328, 5594.552435805207, 5601.187827765033, 5602.719864006865, 5627.409122042127, 5878.0, 5893.5874488785375, 5893.675847828411, 5894.970525147347, 5906.4093590642315, 4116.197341518375, 4130.91738165241, 4152.563980781974, 4153.875383738493, 4158.0, 5528.419515950928, 5655.575831812713, 5661.377248502579, 5694.515966142759, 5707.1724599933605, 5531.2532808072, 5535.197396377584, 5557.02752018387, 5564.970480461127, 5582.665040097607, 5365.731713414391, 5512.779488820403, 5585.1901474286815, 5596.552275818006, 5602.299712535933, 5537.390887002346, 5538.944610553843, 5551.750171242385, 5552.833414997556, 5553.278073850373, 5556.944430555643, 5567.610267281251, 5572.0, 5582.860428489158, 5591.329040515164, 5185.403678577012, 5385.299911011543, 5392.433794451683, 5400.594955378284, 5416.7270691388285], "value": 4269.973458233634, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.2694622742827, 789.8064974081351, 792.0495405513385, 848.2874385516167, 857.245623851011, 15535.378584856606, 16579.83420165798, 16695.081770502617, 16964.74552881708, 16987.405440809573, 13781.793273100911, 13887.930560347184, 13909.791353129685, 13915.652108697263, 13917.37371818268, 635.4471609699556, 642.6593905230235, 728.3081072980663, 734.6620554544916, 738.8263758016861, 739.2496615934831, 745.6532712288785, 746.0897704800135, 746.3693179263514, 746.9551826890404, 793.59526641413, 793.845200185964, 794.2097612875198, 794.3526026288556, 794.9682012719513, 675.152683382352, 683.4122654517112, 759.1080480435521, 788.6727008291581, 790.0913948958714, 567.741677536724, 580.2514755964801, 580.431177446101, 580.4659713063992, 580.8199458167982, 15716.135612541306, 16270.26783794732, 16279.104649244287, 16293.185340732916, 16300.429484968088, 14403.71192576153, 14594.489192878198, 14961.551153465414, 15053.096814191184, 15209.391624335014, 11927.701807454796, 11933.0, 13439.0, 13557.186568805902, 13644.113132646346, 4500.954990450086, 4576.153411618861, 4793.952060479385, 4801.519848015206, 4804.303376010494, 75021.0, 75669.0, 75794.0, 76473.61763191149, 77580.61209693972, 10488.475576221312, 10502.4223667699, 10878.836817447585, 10937.726556836144, 10947.124230061576, 19810.910399928143, 20181.192752289742, 20186.899065504578, 20343.186272548934, 20389.694154587694, 7485.251474852471, 7551.697932082765, 7656.885146722803, 7716.961415192888, 7729.149793522708, 4323.654107671378, 4343.435353404037, 4354.325079612665, 4385.199579623664, 4476.149531588988, 3518.437050071976, 3608.440691692792, 3614.6023937366867, 3616.511770910946, 3872.0707030312524, 683.9794806155824, 692.7713854428026, 697.2539382860291, 700.5796522086707, 708.9361957423856, 753.6721526136148, 761.4451635870985, 779.8479296537121, 795.4074214709963, 806.9318723201492, 10576.153907687367, 10597.894021059845, 10789.892101079045, 10802.67591972242, 10923.617673381394, 728.9648698847649, 764.9120351159577, 781.9296263336327, 783.0994356489969, 795.2127393880018, 4765.380500534909, 5078.263651770472, 5143.434222235551, 5147.510986456281, 5149.742512874342, 76324.61837690776, 77143.91424343076, 79581.60209198917, 79993.0, 81386.0, 50729.23906141411, 52528.47471525312, 69356.0, 70080.2991970084, 70153.2984670157, 56056.43943560676, 56093.15860262099, 56956.57608559819, 57152.0, 58520.414795851495, 10496.265261431932, 10709.57161713554, 10784.137269018303, 10880.183986200907, 11175.10599152082, 35927.28145437129, 40062.0, 41333.58666413297, 41735.7913210432, 42295.0, 47868.28197576969, 49330.26004609862, 49464.25803612877, 50274.0, 52287.0, 12852.0, 12957.22256664603, 12979.675508112372, 12986.545470908473, 13251.734965300833, 14126.223057731924, 14681.559553213421, 14686.175168009553, 15057.171855547613, 15289.77065344043, 13617.319134043457, 14009.0, 14050.648733781738, 14081.788773168615, 14096.224707640768, 13692.863071369158, 13699.931500342833, 14130.081544699562, 14383.496577619733, 14496.637584060483, 13605.183688978694, 13692.863071369158, 14067.577972660836, 14153.575392737823, 14247.572572822832, 10102.625882917362, 10166.542505587415, 10244.948775256076, 10388.272820902464, 10629.787404251718, 10681.305715128492, 10758.354498730101, 10798.244122911636, 10940.39827809478, 10986.780264394827], "value": 7214.509719472075, "unit": "score"}], "name": "dromaeo_css", "value": 7300.376922255124, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 111.0, 111.0, 110.0, 113.0, 111.0, 112.0, 111.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 118.0, 118.0, 170.0, 122.0, 118.0, 120.0, 118.0, 153.0, 124.0], "value": 131.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 161.0, 162.0, 171.0, 161.0, 161.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 121.0, 77.0, 75.0, 75.0, 76.0, 90.0, 76.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 104.0, 82.0, 84.0, 84.0, 95.0, 84.0, 83.0, 107.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 118.0, 117.0, 116.0, 117.0, 118.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 148.0, 146.0, 148.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 51.0, 50.0, 51.0, 52.0, 52.0, 51.0, 52.0, 51.0], "value": 51.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 66.0, 68.0, 68.0, 68.0], "value": 67.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 85.0, 83.0, 85.0, 92.0, 90.0, 92.0, 83.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 142.0, 126.0, 129.0, 125.0, 135.0, 130.0, 125.0, 161.0, 125.0], "value": 133.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 172.0, 170.0, 169.0, 174.0, 170.0, 171.0, 169.0, 173.0], "value": 171.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 62.0, 63.0, 63.0, 69.0, 61.0, 61.0, 61.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1506.6000000000001, "alertThreshold": 2.0}]} 17:03:59 INFO - Return code: 0 17:03:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:03:59 ERROR - # TBPL SUCCESS # 17:03:59 INFO - Running post-action listener: _resource_record_post_action 17:03:59 INFO - [mozharness: 2017-01-14 01:03:59.281023Z] Finished run-tests step (success) 17:03:59 INFO - Running post-run listener: _resource_record_post_run 17:03:59 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 416055296; Read time: 12; Write time: 281116 17:03:59 INFO - TinderboxPrint: CPU usage
13.0% 17:03:59 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:03:59 INFO - TinderboxPrint: I/O write bytes / time
416,055,296 / 281,116 17:03:59 INFO - TinderboxPrint: CPU idle
8,286.5 (86.9%) 17:03:59 INFO - TinderboxPrint: CPU user
1,197.9 (12.6%) 17:03:59 INFO - TinderboxPrint: Swap in / out
0 / 0 17:03:59 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106020864; Read time: 0; Write time: 86644 17:03:59 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295370752; Read time: 12; Write time: 188596 17:03:59 INFO - Running post-run listener: _upload_blobber_files 17:03:59 INFO - Blob upload gear active. 17:03:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:03:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:03:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:04:00 INFO - (blobuploader) - INFO - Open directory for files ... 17:04:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:04:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:04:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:01 INFO - (blobuploader) - INFO - Done attempting. 17:04:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:04:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:04:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:01 INFO - (blobuploader) - INFO - Done attempting. 17:04:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:04:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:04:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:02 INFO - (blobuploader) - INFO - Done attempting. 17:04:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:04:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:04:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:06 INFO - (blobuploader) - INFO - Done attempting. 17:04:06 INFO - (blobuploader) - INFO - Iteration through files over. 17:04:06 INFO - Return code: 0 17:04:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:04:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:04:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2dadea5ff3c7686387f927e5076afba3cd28a0f253cd0049ecdcbd08c8759846d17115d2834e533de285ad9968ba68e32ac616dfd7fa28dcd76480f73817ae57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d09574339bf26ce2064bf3159c482e30f93a66926f408766e662387df7c5abb6a3fc32c762c39f6a6b51a5bc231ac904592709c9ec4ec07b758f6ffbe3948feb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1de19af0ce007d83e0da135c0ab23c8d319259243c958df85ea489f4c48b7136fad01422f8ae4eb12f01dd3045b89724fdc029388ce74c2198640b9bdfc6a596", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8f67ea14cbb8c2072c1b4c297db5d79c76542db605cd73516991f7a25fe1ebba630d46f93a152cba39b29dea91d576a0eeb956dc1c6915fea485be61eaa67a6b"} 17:04:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:04:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:04:06 INFO - Contents: 17:04:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2dadea5ff3c7686387f927e5076afba3cd28a0f253cd0049ecdcbd08c8759846d17115d2834e533de285ad9968ba68e32ac616dfd7fa28dcd76480f73817ae57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d09574339bf26ce2064bf3159c482e30f93a66926f408766e662387df7c5abb6a3fc32c762c39f6a6b51a5bc231ac904592709c9ec4ec07b758f6ffbe3948feb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1de19af0ce007d83e0da135c0ab23c8d319259243c958df85ea489f4c48b7136fad01422f8ae4eb12f01dd3045b89724fdc029388ce74c2198640b9bdfc6a596", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8f67ea14cbb8c2072c1b4c297db5d79c76542db605cd73516991f7a25fe1ebba630d46f93a152cba39b29dea91d576a0eeb956dc1c6915fea485be61eaa67a6b"} 17:04:06 INFO - Running post-run listener: copy_logs_to_upload_dir 17:04:06 INFO - Copying logs to upload dir... 17:04:06 INFO - mkdir: /builds/slave/test/build/upload/logs 17:04:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.870294 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-13 17:04:05.859485) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 17:04:05.862591) ========= 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-1484354049.71403-85007996 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/2dadea5ff3c7686387f927e5076afba3cd28a0f253cd0049ecdcbd08c8759846d17115d2834e533de285ad9968ba68e32ac616dfd7fa28dcd76480f73817ae57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d09574339bf26ce2064bf3159c482e30f93a66926f408766e662387df7c5abb6a3fc32c762c39f6a6b51a5bc231ac904592709c9ec4ec07b758f6ffbe3948feb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1de19af0ce007d83e0da135c0ab23c8d319259243c958df85ea489f4c48b7136fad01422f8ae4eb12f01dd3045b89724fdc029388ce74c2198640b9bdfc6a596", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8f67ea14cbb8c2072c1b4c297db5d79c76542db605cd73516991f7a25fe1ebba630d46f93a152cba39b29dea91d576a0eeb956dc1c6915fea485be61eaa67a6b"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484348225/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011807 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1484348225/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/2dadea5ff3c7686387f927e5076afba3cd28a0f253cd0049ecdcbd08c8759846d17115d2834e533de285ad9968ba68e32ac616dfd7fa28dcd76480f73817ae57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d09574339bf26ce2064bf3159c482e30f93a66926f408766e662387df7c5abb6a3fc32c762c39f6a6b51a5bc231ac904592709c9ec4ec07b758f6ffbe3948feb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1de19af0ce007d83e0da135c0ab23c8d319259243c958df85ea489f4c48b7136fad01422f8ae4eb12f01dd3045b89724fdc029388ce74c2198640b9bdfc6a596", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8f67ea14cbb8c2072c1b4c297db5d79c76542db605cd73516991f7a25fe1ebba630d46f93a152cba39b29dea91d576a0eeb956dc1c6915fea485be61eaa67a6b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 17:04:05.889324) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 17:04:05.889764) ========= 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-1484354049.71403-85007996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004419 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 17:04:05.974239) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 17:04:05.974569) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 17:04:05.974855) ========= ========= Total master_lag: 0.17 =========