builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1470409496.73 results: success (0) buildid: 20160805063002 builduid: b4ef6dc4b89e4974a463af2d2f782b14 revision: 192132a4cbc78fa948ad1e37c204f537043fc37e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 08:04:56.734152) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 08:04:56.734614) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 08:04:56.734973) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 08:04:56.753716) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 08:04:56.754050) ========= 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=6d15e502d8e29d5d2676d664000001c3-1470409325.720656-1414100035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-05 08:04:56-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 58.0M=0s 2016-08-05 08:04:56 (58.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090393 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 08:04:56.861208) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 08:04:56.862115) ========= 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=6d15e502d8e29d5d2676d664000001c3-1470409325.720656-1414100035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014936 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 08:04:56.911941) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 08:04:56.912280) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 192132a4cbc78fa948ad1e37c204f537043fc37e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 192132a4cbc78fa948ad1e37c204f537043fc37e --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=6d15e502d8e29d5d2676d664000001c3-1470409325.720656-1414100035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-05 08:04:57,056 truncating revision to first 12 chars 2016-08-05 08:04:57,057 Setting DEBUG logging. 2016-08-05 08:04:57,057 attempt 1/10 2016-08-05 08:04:57,057 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/192132a4cbc7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-05 08:04:57,423 unpacking tar archive at: autoland-192132a4cbc7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.703644 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 08:04:57.635460) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 08:04:57.635767) ========= script_repo_revision: 192132a4cbc78fa948ad1e37c204f537043fc37e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 08:04:57.636271) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 08:04:57.636608) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 08:04:57.648850) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-05 08:04:57.649224) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=6d15e502d8e29d5d2676d664000001c3-1470409325.720656-1414100035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:04:57 INFO - MultiFileLogger online at 20160805 08:04:57 in /builds/slave/test 08:04:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 08:04:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:04:57 INFO - {'append_to_log': False, 08:04:57 INFO - 'base_work_dir': '/builds/slave/test', 08:04:57 INFO - 'blob_upload_branch': 'Autoland', 08:04:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:04:57 INFO - 'branch': 'Autoland', 08:04:57 INFO - 'buildbot_json_path': 'buildprops.json', 08:04:57 INFO - 'config_files': ('talos/linux_config.py',), 08:04:57 INFO - 'default_actions': ('clobber', 08:04:57 INFO - 'read-buildbot-config', 08:04:57 INFO - 'download-and-extract', 08:04:57 INFO - 'populate-webroot', 08:04:57 INFO - 'create-virtualenv', 08:04:57 INFO - 'install', 08:04:57 INFO - 'run-tests'), 08:04:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:04:57 INFO - 'download_minidump_stackwalk': True, 08:04:57 INFO - 'download_symbols': 'ondemand', 08:04:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:04:57 INFO - 'tooltool.py': '/tools/tooltool.py', 08:04:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:04:57 INFO - '/tools/misc-python/virtualenv.py')}, 08:04:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:04:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:04:57 INFO - 'installer_path': 'installer.exe', 08:04:57 INFO - 'log_level': 'info', 08:04:57 INFO - 'log_name': 'talos', 08:04:57 INFO - 'log_to_console': True, 08:04:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:04:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:04:57 INFO - 'opt_config_files': (), 08:04:57 INFO - 'pip_index': False, 08:04:57 INFO - 'sps_profile': False, 08:04:57 INFO - 'sps_profile_interval': 0, 08:04:57 INFO - 'suite': 'dromaeojs', 08:04:57 INFO - 'system_bits': '32', 08:04:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:04:57 INFO - 'title': 'talos-linux64-ix-023', 08:04:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:04:57 INFO - 'use_talos_json': True, 08:04:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:04:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:04:57 INFO - 'work_dir': 'build'} 08:04:57 INFO - [mozharness: 2016-08-05 15:04:57.886594Z] Running clobber step. 08:04:57 INFO - Running pre-action listener: _resource_record_pre_action 08:04:57 INFO - Running main action method: clobber 08:04:57 INFO - rmtree: /builds/slave/test/build 08:04:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:04:58 INFO - Running post-action listener: _resource_record_post_action 08:04:58 INFO - [mozharness: 2016-08-05 15:04:58.844668Z] Finished clobber step (success) 08:04:58 INFO - [mozharness: 2016-08-05 15:04:58.844769Z] Running read-buildbot-config step. 08:04:58 INFO - Running pre-action listener: _resource_record_pre_action 08:04:58 INFO - Running main action method: read_buildbot_config 08:04:58 INFO - Using buildbot properties: 08:04:58 INFO - { 08:04:58 INFO - "project": "", 08:04:58 INFO - "product": "firefox", 08:04:58 INFO - "script_repo_revision": "production", 08:04:58 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 08:04:58 INFO - "repository": "", 08:04:58 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 08:04:58 INFO - "buildid": "20160805063002", 08:04:58 INFO - "pgo_build": "True", 08:04:58 INFO - "basedir": "/builds/slave/test", 08:04:58 INFO - "buildnumber": 88, 08:04:58 INFO - "slavename": "talos-linux64-ix-023", 08:04:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:04:58 INFO - "platform": "ubuntu64_hw", 08:04:58 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 08:04:58 INFO - "branch": "autoland", 08:04:58 INFO - "repo_path": "integration/autoland", 08:04:58 INFO - "revision": "192132a4cbc78fa948ad1e37c204f537043fc37e", 08:04:58 INFO - "stage_platform": "linux64-pgo", 08:04:58 INFO - "builduid": "b4ef6dc4b89e4974a463af2d2f782b14", 08:04:58 INFO - "slavebuilddir": "test" 08:04:58 INFO - } 08:04:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/M6tcCWwlTUWE7KtfM6gt9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:04:58 INFO - Running post-action listener: _resource_record_post_action 08:04:58 INFO - [mozharness: 2016-08-05 15:04:58.847185Z] Finished read-buildbot-config step (success) 08:04:58 INFO - [mozharness: 2016-08-05 15:04:58.847273Z] Running download-and-extract step. 08:04:58 INFO - Running pre-action listener: _resource_record_pre_action 08:04:58 INFO - Running main action method: download_and_extract 08:04:58 INFO - mkdir: /builds/slave/test/build/tests 08:04:58 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')]} 08:04:58 INFO - trying https://queue.taskcluster.net/v1/task/M6tcCWwlTUWE7KtfM6gt9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:04:58 INFO - Downloading https://queue.taskcluster.net/v1/task/M6tcCWwlTUWE7KtfM6gt9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:04:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M6tcCWwlTUWE7KtfM6gt9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:04:59 INFO - Downloaded 1361 bytes. 08:04:59 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:04:59 INFO - Using the following test package requirements: 08:04:59 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:04:59 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:04:59 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:04:59 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:59 INFO - u'jsshell-linux-x86_64.zip'], 08:04:59 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:04:59 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:04:59 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:04:59 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:04:59 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:04:59 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:04:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:59 INFO - trying https://queue.taskcluster.net/v1/task/M6tcCWwlTUWE7KtfM6gt9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:04:59 INFO - Downloading https://queue.taskcluster.net/v1/task/M6tcCWwlTUWE7KtfM6gt9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:04:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M6tcCWwlTUWE7KtfM6gt9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:05:00 INFO - Downloaded 21825483 bytes. 08:05:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:05:04 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:05: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')]} 08:05:04 INFO - trying https://queue.taskcluster.net/v1/task/M6tcCWwlTUWE7KtfM6gt9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:05:04 INFO - Downloading https://queue.taskcluster.net/v1/task/M6tcCWwlTUWE7KtfM6gt9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:05:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M6tcCWwlTUWE7KtfM6gt9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:05:05 INFO - Downloaded 21825483 bytes. 08:05:05 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:05:10 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')]} 08:05:10 INFO - trying https://queue.taskcluster.net/v1/task/M6tcCWwlTUWE7KtfM6gt9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:05:10 INFO - Downloading https://queue.taskcluster.net/v1/task/M6tcCWwlTUWE7KtfM6gt9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:05:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M6tcCWwlTUWE7KtfM6gt9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:05:11 INFO - Downloaded 14413723 bytes. 08:05:11 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 08:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:11 INFO - trying https://queue.taskcluster.net/v1/task/M6tcCWwlTUWE7KtfM6gt9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:05:11 INFO - Downloading https://queue.taskcluster.net/v1/task/M6tcCWwlTUWE7KtfM6gt9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:05:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M6tcCWwlTUWE7KtfM6gt9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:05:13 INFO - Downloaded 59351215 bytes. 08:05:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M6tcCWwlTUWE7KtfM6gt9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:05:13 INFO - mkdir: /builds/slave/test/properties 08:05:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:05:13 INFO - Writing to file /builds/slave/test/properties/build_url 08:05:13 INFO - Contents: 08:05:13 INFO - build_url:https://queue.taskcluster.net/v1/task/M6tcCWwlTUWE7KtfM6gt9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:05:13 INFO - Running post-action listener: _resource_record_post_action 08:05:13 INFO - Running post-action listener: set_extra_try_arguments 08:05:13 INFO - [mozharness: 2016-08-05 15:05:13.950322Z] Finished download-and-extract step (success) 08:05:13 INFO - [mozharness: 2016-08-05 15:05:13.950547Z] Running populate-webroot step. 08:05:13 INFO - Running pre-action listener: _resource_record_pre_action 08:05:13 INFO - Running main action method: populate_webroot 08:05:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:05:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:05:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:05:13 INFO - '--tppagecycles', 08:05:13 INFO - '7'], 08:05:13 INFO - 'tests': ['tsvgm']}}, 08:05:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:05:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:05:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:05:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:05:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:05:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:05:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:13 INFO - 'talos_options': ['--disable-e10s'], 08:05:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:05:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:05:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:13 INFO - 'talos_options': ['--disable-e10s'], 08:05:13 INFO - 'tests': ['damp', 'tps']}, 08:05:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:13 INFO - 'tests': ['damp', 'tps']}, 08:05:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:05:13 INFO - 'tests': ['dromaeo_dom']}, 08:05:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:05:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:05:13 INFO - 'tests': ['basic_compositor_video']}, 08:05:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:05:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:05:13 INFO - 'tests': ['a11yr', 08:05:13 INFO - 'ts_paint', 08:05:13 INFO - 'tpaint', 08:05:13 INFO - 'sessionrestore', 08:05:13 INFO - 'sessionrestore_no_auto_restore', 08:05:13 INFO - 'tabpaint']}, 08:05:13 INFO - 'other-e10s': {'tests': ['a11yr', 08:05:13 INFO - 'ts_paint', 08:05:13 INFO - 'tpaint', 08:05:13 INFO - 'sessionrestore', 08:05:13 INFO - 'sessionrestore_no_auto_restore', 08:05:13 INFO - 'tabpaint']}, 08:05:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:05:13 INFO - 'ts_paint', 08:05:13 INFO - 'tpaint', 08:05:13 INFO - 'sessionrestore', 08:05:13 INFO - 'sessionrestore_no_auto_restore', 08:05:13 INFO - 'tabpaint']}, 08:05:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:05:13 INFO - 'ts_paint', 08:05:13 INFO - 'tpaint', 08:05:13 INFO - 'sessionrestore', 08:05:13 INFO - 'sessionrestore_no_auto_restore', 08:05:13 INFO - 'tabpaint']}, 08:05:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:05:13 INFO - 'tests': ['a11yr', 08:05:13 INFO - 'ts_paint', 08:05:13 INFO - 'tpaint', 08:05:13 INFO - 'sessionrestore', 08:05:13 INFO - 'sessionrestore_no_auto_restore', 08:05:13 INFO - 'tabpaint']}, 08:05:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:05:13 INFO - 'tests': ['a11yr', 08:05:13 INFO - 'ts_paint', 08:05:13 INFO - 'tpaint', 08:05:13 INFO - 'sessionrestore', 08:05:13 INFO - 'sessionrestore_no_auto_restore', 08:05:13 INFO - 'tabpaint']}, 08:05:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:05:13 INFO - 'tests': ['tsvgx', 08:05:13 INFO - 'tsvgr_opacity', 08:05:13 INFO - 'tart', 08:05:13 INFO - 'tscrollx', 08:05:13 INFO - 'cart']}, 08:05:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:05:13 INFO - 'tsvgr_opacity', 08:05:13 INFO - 'tart', 08:05:13 INFO - 'tscrollx', 08:05:13 INFO - 'cart']}, 08:05:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:13 INFO - 'talos_options': ['--disable-e10s'], 08:05:13 INFO - 'tests': ['tp5o']}, 08:05:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:13 INFO - 'tests': ['tp5o']}, 08:05:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:13 INFO - 'talos_options': ['--disable-e10s', 08:05:13 INFO - '--xperf_path', 08:05:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:05:13 INFO - 'tests': ['tp5n']}, 08:05:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:05:13 INFO - 'talos_options': ['--xperf_path', 08:05:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:05:13 INFO - 'tests': ['tp5n']}}, 08:05:13 INFO - 'talos.zip': {'path': '', 08:05:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:05:13 INFO - Running post-action listener: _resource_record_post_action 08:05:13 INFO - [mozharness: 2016-08-05 15:05:13.973060Z] Finished populate-webroot step (success) 08:05:13 INFO - [mozharness: 2016-08-05 15:05:13.973148Z] Running create-virtualenv step. 08:05:13 INFO - Running pre-action listener: _resource_record_pre_action 08:05:13 INFO - Running main action method: create_virtualenv 08:05:13 INFO - Creating virtualenv /builds/slave/test/build/venv 08:05:13 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 08:05:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:05:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:05:14 INFO - Using real prefix '/usr' 08:05:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:05:14 INFO - Installing distribute.............................................................................................................................................................................................done. 08:05:16 INFO - Installing pip.................done. 08:05:16 INFO - Return code: 0 08:05:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b3b0>, '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 0x2b4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c740>, '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': '6d15e502d8e29d5d2676d664000001c3-1470409325.720656-1414100035', '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 08:05:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:05:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:05:16 INFO - Using env: {'DISPLAY': ':0', 08:05:16 INFO - 'HOME': '/home/cltbld', 08:05:16 INFO - 'LANG': 'en_US.UTF-8', 08:05:16 INFO - 'LANGUAGE': 'en_US:en', 08:05:16 INFO - 'LOGNAME': 'cltbld', 08:05:16 INFO - 'MAIL': '/var/mail/cltbld', 08:05:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:16 INFO - 'MOZ_NO_REMOTE': '1', 08:05:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:16 INFO - 'NO_EM_RESTART': '1', 08:05:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:16 INFO - 'PWD': '/builds/slave/test', 08:05:16 INFO - 'SHELL': '/bin/bash', 08:05:16 INFO - 'SHLVL': '1', 08:05:16 INFO - 'TERM': 'linux', 08:05:16 INFO - 'TMOUT': '86400', 08:05:16 INFO - 'USER': 'cltbld', 08:05:16 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470409325.720656-1414100035', 08:05:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:16 INFO - '_': '/tools/buildbot/bin/python'} 08:05:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:16 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 08:05:16 INFO - Cleaning up... 08:05:16 INFO - Return code: 0 08:05:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x288c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b3b0>, '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 0x2b4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c740>, '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': '6d15e502d8e29d5d2676d664000001c3-1470409325.720656-1414100035', '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 08:05:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:05:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:05:16 INFO - Using env: {'DISPLAY': ':0', 08:05:16 INFO - 'HOME': '/home/cltbld', 08:05:16 INFO - 'LANG': 'en_US.UTF-8', 08:05:16 INFO - 'LANGUAGE': 'en_US:en', 08:05:16 INFO - 'LOGNAME': 'cltbld', 08:05:16 INFO - 'MAIL': '/var/mail/cltbld', 08:05:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:16 INFO - 'MOZ_NO_REMOTE': '1', 08:05:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:16 INFO - 'NO_EM_RESTART': '1', 08:05:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:16 INFO - 'PWD': '/builds/slave/test', 08:05:16 INFO - 'SHELL': '/bin/bash', 08:05:16 INFO - 'SHLVL': '1', 08:05:16 INFO - 'TERM': 'linux', 08:05:16 INFO - 'TMOUT': '86400', 08:05:16 INFO - 'USER': 'cltbld', 08:05:16 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470409325.720656-1414100035', 08:05:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:16 INFO - '_': '/tools/buildbot/bin/python'} 08:05:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:16 INFO - Downloading/unpacking psutil>=3.1.1 08:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:05:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:05:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:05:18 INFO - Installing collected packages: psutil 08:05:18 INFO - Running setup.py install for psutil 08:05:18 INFO - building 'psutil._psutil_linux' extension 08:05:19 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 08:05:19 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 08:05:19 INFO - building 'psutil._psutil_posix' extension 08:05:19 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 08:05:19 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 08:05:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:05:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:05:19 INFO - Successfully installed psutil 08:05:19 INFO - Cleaning up... 08:05:19 INFO - Return code: 0 08:05:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b3b0>, '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 0x2b4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c740>, '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': '6d15e502d8e29d5d2676d664000001c3-1470409325.720656-1414100035', '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 08:05:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:05:19 INFO - Using env: {'DISPLAY': ':0', 08:05:19 INFO - 'HOME': '/home/cltbld', 08:05:19 INFO - 'LANG': 'en_US.UTF-8', 08:05:19 INFO - 'LANGUAGE': 'en_US:en', 08:05:19 INFO - 'LOGNAME': 'cltbld', 08:05:19 INFO - 'MAIL': '/var/mail/cltbld', 08:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:19 INFO - 'MOZ_NO_REMOTE': '1', 08:05:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:19 INFO - 'NO_EM_RESTART': '1', 08:05:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:19 INFO - 'PWD': '/builds/slave/test', 08:05:19 INFO - 'SHELL': '/bin/bash', 08:05:19 INFO - 'SHLVL': '1', 08:05:19 INFO - 'TERM': 'linux', 08:05:19 INFO - 'TMOUT': '86400', 08:05:19 INFO - 'USER': 'cltbld', 08:05:19 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470409325.720656-1414100035', 08:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:19 INFO - '_': '/tools/buildbot/bin/python'} 08:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:05:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:05:21 INFO - Installing collected packages: mozsystemmonitor 08:05:21 INFO - Running setup.py install for mozsystemmonitor 08:05:21 INFO - Successfully installed mozsystemmonitor 08:05:21 INFO - Cleaning up... 08:05:21 INFO - Return code: 0 08:05:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:05:21 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')]} 08:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:21 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')]} 08:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:21 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 0x288c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b3b0>, '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 0x2b4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c740>, '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': '6d15e502d8e29d5d2676d664000001c3-1470409325.720656-1414100035', '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 08:05:21 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 08:05:21 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 08:05:21 INFO - Using env: {'DISPLAY': ':0', 08:05:21 INFO - 'HOME': '/home/cltbld', 08:05:21 INFO - 'LANG': 'en_US.UTF-8', 08:05:21 INFO - 'LANGUAGE': 'en_US:en', 08:05:21 INFO - 'LOGNAME': 'cltbld', 08:05:21 INFO - 'MAIL': '/var/mail/cltbld', 08:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:21 INFO - 'MOZ_NO_REMOTE': '1', 08:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:21 INFO - 'NO_EM_RESTART': '1', 08:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:21 INFO - 'PWD': '/builds/slave/test', 08:05:21 INFO - 'SHELL': '/bin/bash', 08:05:21 INFO - 'SHLVL': '1', 08:05:21 INFO - 'TERM': 'linux', 08:05:21 INFO - 'TMOUT': '86400', 08:05:21 INFO - 'USER': 'cltbld', 08:05:21 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470409325.720656-1414100035', 08:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:21 INFO - '_': '/tools/buildbot/bin/python'} 08:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:21 INFO - Downloading/unpacking jsonschema==2.5.1 08:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:05:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:24 INFO - Downloading functools32-3.2.3-2.tar.gz 08:05:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:05:24 INFO - warning: no files found matching '*.txt' 08:05:24 INFO - no previously-included directories found matching 'build' 08:05:24 INFO - no previously-included directories found matching 'dist' 08:05:24 INFO - no previously-included directories found matching '.git*' 08:05:24 INFO - Installing collected packages: jsonschema, functools32 08:05:24 INFO - Running setup.py install for functools32 08:05:24 INFO - warning: no files found matching '*.txt' 08:05:24 INFO - no previously-included directories found matching 'build' 08:05:24 INFO - no previously-included directories found matching 'dist' 08:05:24 INFO - no previously-included directories found matching '.git*' 08:05:24 INFO - Successfully installed jsonschema functools32 08:05:24 INFO - Cleaning up... 08:05:24 INFO - Return code: 0 08:05:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:24 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 0x288c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b3b0>, '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 0x2b4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c740>, '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': '6d15e502d8e29d5d2676d664000001c3-1470409325.720656-1414100035', '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 08:05:24 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 08:05:24 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 08:05:24 INFO - Using env: {'DISPLAY': ':0', 08:05:24 INFO - 'HOME': '/home/cltbld', 08:05:24 INFO - 'LANG': 'en_US.UTF-8', 08:05:24 INFO - 'LANGUAGE': 'en_US:en', 08:05:24 INFO - 'LOGNAME': 'cltbld', 08:05:24 INFO - 'MAIL': '/var/mail/cltbld', 08:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:24 INFO - 'MOZ_NO_REMOTE': '1', 08:05:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:24 INFO - 'NO_EM_RESTART': '1', 08:05:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:24 INFO - 'PWD': '/builds/slave/test', 08:05:24 INFO - 'SHELL': '/bin/bash', 08:05:24 INFO - 'SHLVL': '1', 08:05:24 INFO - 'TERM': 'linux', 08:05:24 INFO - 'TMOUT': '86400', 08:05:24 INFO - 'USER': 'cltbld', 08:05:24 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470409325.720656-1414100035', 08:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:24 INFO - '_': '/tools/buildbot/bin/python'} 08:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:05:24 INFO - Cleaning up... 08:05:24 INFO - Return code: 0 08:05:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:24 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 0x288c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b3b0>, '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 0x2b4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c740>, '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': '6d15e502d8e29d5d2676d664000001c3-1470409325.720656-1414100035', '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 08:05:24 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 08:05:24 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 08:05:24 INFO - Using env: {'DISPLAY': ':0', 08:05:24 INFO - 'HOME': '/home/cltbld', 08:05:24 INFO - 'LANG': 'en_US.UTF-8', 08:05:24 INFO - 'LANGUAGE': 'en_US:en', 08:05:24 INFO - 'LOGNAME': 'cltbld', 08:05:24 INFO - 'MAIL': '/var/mail/cltbld', 08:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:24 INFO - 'MOZ_NO_REMOTE': '1', 08:05:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:24 INFO - 'NO_EM_RESTART': '1', 08:05:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:24 INFO - 'PWD': '/builds/slave/test', 08:05:24 INFO - 'SHELL': '/bin/bash', 08:05:24 INFO - 'SHLVL': '1', 08:05:24 INFO - 'TERM': 'linux', 08:05:24 INFO - 'TMOUT': '86400', 08:05:24 INFO - 'USER': 'cltbld', 08:05:24 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470409325.720656-1414100035', 08:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:24 INFO - '_': '/tools/buildbot/bin/python'} 08:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:24 INFO - Downloading/unpacking blobuploader==1.2.4 08:05:24 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 08:05:24 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 08:05:24 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 08:05:24 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 08:05:24 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 08:05:24 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 08:05:26 INFO - Downloading blobuploader-1.2.4.tar.gz 08:05:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:05:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:05:26 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 08:05:26 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 08:05:26 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 08:05:26 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 08:05:26 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 08:05:26 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 08:05:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:05:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:27 INFO - Downloading docopt-0.6.1.tar.gz 08:05:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:05:27 INFO - Installing collected packages: blobuploader, requests, docopt 08:05:27 INFO - Running setup.py install for blobuploader 08:05:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:05:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:05:27 INFO - Running setup.py install for requests 08:05:27 INFO - Running setup.py install for docopt 08:05:27 INFO - Successfully installed blobuploader requests docopt 08:05:27 INFO - Cleaning up... 08:05:27 INFO - Return code: 0 08:05:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:28 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')]} 08:05:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:28 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 0x288c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b3b0>, '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 0x2b4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c740>, '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': '6d15e502d8e29d5d2676d664000001c3-1470409325.720656-1414100035', '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 08:05:28 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 08:05:28 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 08:05:28 INFO - Using env: {'DISPLAY': ':0', 08:05:28 INFO - 'HOME': '/home/cltbld', 08:05:28 INFO - 'LANG': 'en_US.UTF-8', 08:05:28 INFO - 'LANGUAGE': 'en_US:en', 08:05:28 INFO - 'LOGNAME': 'cltbld', 08:05:28 INFO - 'MAIL': '/var/mail/cltbld', 08:05:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:28 INFO - 'MOZ_NO_REMOTE': '1', 08:05:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:28 INFO - 'NO_EM_RESTART': '1', 08:05:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:28 INFO - 'PWD': '/builds/slave/test', 08:05:28 INFO - 'SHELL': '/bin/bash', 08:05:28 INFO - 'SHLVL': '1', 08:05:28 INFO - 'TERM': 'linux', 08:05:28 INFO - 'TMOUT': '86400', 08:05:28 INFO - 'USER': 'cltbld', 08:05:28 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470409325.720656-1414100035', 08:05:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:28 INFO - '_': '/tools/buildbot/bin/python'} 08:05:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:05:28 INFO - Running setup.py (path:/tmp/pip-NTsfhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:05:28 INFO - Running setup.py (path:/tmp/pip-zBz1vr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:05:28 INFO - Running setup.py (path:/tmp/pip-UCS5BB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:05:28 INFO - Running setup.py (path:/tmp/pip-gGdhcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:05:28 INFO - Running setup.py (path:/tmp/pip-UkbscK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:05:28 INFO - Running setup.py (path:/tmp/pip-evBCW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:05:28 INFO - Running setup.py (path:/tmp/pip-_ACVvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:05:28 INFO - Running setup.py (path:/tmp/pip-Jr0an3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:05:28 INFO - Running setup.py (path:/tmp/pip-_JZV_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:05:28 INFO - Running setup.py (path:/tmp/pip-M_1_iS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:05:28 INFO - Running setup.py (path:/tmp/pip-HErI6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:05:29 INFO - Running setup.py (path:/tmp/pip-NiPV5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:05:29 INFO - Running setup.py (path:/tmp/pip-l12nSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:05:29 INFO - Running setup.py (path:/tmp/pip-dxdkoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:29 INFO - Running setup.py (path:/tmp/pip-CNTrrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:05:29 INFO - Running setup.py (path:/tmp/pip-BcGgAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:05:29 INFO - Running setup.py (path:/tmp/pip-ciQ_9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:05:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:05:29 INFO - Running setup.py install for manifestparser 08:05:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:05:29 INFO - Running setup.py install for mozcrash 08:05:29 INFO - Running setup.py install for mozdebug 08:05:29 INFO - Running setup.py install for mozdevice 08:05:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:05:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:05:29 INFO - Running setup.py install for mozfile 08:05:29 INFO - Running setup.py install for mozhttpd 08:05:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:05:30 INFO - Running setup.py install for mozinfo 08:05:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:05:30 INFO - Running setup.py install for mozInstall 08:05:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:05:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:05:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:05:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:05:30 INFO - Running setup.py install for mozleak 08:05:30 INFO - Running setup.py install for mozlog 08:05:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:05:30 INFO - Running setup.py install for moznetwork 08:05:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:05:30 INFO - Running setup.py install for mozprocess 08:05:30 INFO - Running setup.py install for mozprofile 08:05:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:05:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:05:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:05:30 INFO - Running setup.py install for mozrunner 08:05:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:05:30 INFO - Running setup.py install for mozscreenshot 08:05:31 INFO - Running setup.py install for moztest 08:05:31 INFO - Running setup.py install for mozversion 08:05:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:05:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:05:31 INFO - Cleaning up... 08:05:31 INFO - Return code: 0 08:05:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05: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')]} 08:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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')]} 08:05:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:31 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 0x288c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b3b0>, '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 0x2b4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c740>, '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': '6d15e502d8e29d5d2676d664000001c3-1470409325.720656-1414100035', '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 08:05:31 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 08:05:31 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 08:05:31 INFO - Using env: {'DISPLAY': ':0', 08:05:31 INFO - 'HOME': '/home/cltbld', 08:05:31 INFO - 'LANG': 'en_US.UTF-8', 08:05:31 INFO - 'LANGUAGE': 'en_US:en', 08:05:31 INFO - 'LOGNAME': 'cltbld', 08:05:31 INFO - 'MAIL': '/var/mail/cltbld', 08:05:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:31 INFO - 'MOZ_NO_REMOTE': '1', 08:05:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:31 INFO - 'NO_EM_RESTART': '1', 08:05:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:31 INFO - 'PWD': '/builds/slave/test', 08:05:31 INFO - 'SHELL': '/bin/bash', 08:05:31 INFO - 'SHLVL': '1', 08:05:31 INFO - 'TERM': 'linux', 08:05:31 INFO - 'TMOUT': '86400', 08:05:31 INFO - 'USER': 'cltbld', 08:05:31 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470409325.720656-1414100035', 08:05:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:31 INFO - '_': '/tools/buildbot/bin/python'} 08:05:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:05:31 INFO - Running setup.py (path:/tmp/pip-L4vH5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:05:31 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)) 08:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:05:31 INFO - Running setup.py (path:/tmp/pip-_Kv1Rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:05:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:05:31 INFO - Running setup.py (path:/tmp/pip-q5QUXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:05:31 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)) 08:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:05:31 INFO - Running setup.py (path:/tmp/pip-BbfQVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:05:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:05:31 INFO - Running setup.py (path:/tmp/pip-hKE4pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:05:31 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)) 08:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:05:31 INFO - Running setup.py (path:/tmp/pip-OnY3cy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:05:31 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)) 08:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:05:31 INFO - Running setup.py (path:/tmp/pip-tdmVZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:05:32 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)) 08:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:05:32 INFO - Running setup.py (path:/tmp/pip-_w7WlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:05:32 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)) 08:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:05:32 INFO - Running setup.py (path:/tmp/pip-hJy5oa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:05:32 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)) 08:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:05:32 INFO - Running setup.py (path:/tmp/pip-Zt_myE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 08:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:05:32 INFO - Running setup.py (path:/tmp/pip-6Nz5sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:05:32 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)) 08:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:05:32 INFO - Running setup.py (path:/tmp/pip-jn2nRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:05:32 INFO - Running setup.py (path:/tmp/pip-H_WSfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:05:32 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)) 08:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:05:32 INFO - Running setup.py (path:/tmp/pip-GN35zR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:32 INFO - Running setup.py (path:/tmp/pip-ZHAltg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:05:32 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)) 08:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:05:32 INFO - Running setup.py (path:/tmp/pip-XTed3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:05:32 INFO - Running setup.py (path:/tmp/pip-O9ezVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:05:32 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)) 08:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:05:32 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)) 08:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:05:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:05:32 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 08:05:32 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 08:05:32 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 08:05:32 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 08:05:32 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 08:05:32 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 08:05:34 INFO - Downloading blessings-1.6.tar.gz 08:05:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:05:34 INFO - Installing collected packages: blessings 08:05:34 INFO - Running setup.py install for blessings 08:05:34 INFO - Successfully installed blessings 08:05:34 INFO - Cleaning up... 08:05:34 INFO - Return code: 0 08:05:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:05:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:05:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:05:35 INFO - Reading from file tmpfile_stdout 08:05:35 INFO - Current package versions: 08:05:35 INFO - argparse == 1.2.1 08:05:35 INFO - blessings == 1.6 08:05:35 INFO - blobuploader == 1.2.4 08:05:35 INFO - docopt == 0.6.1 08:05:35 INFO - functools32 == 3.2.3-2 08:05:35 INFO - jsonschema == 2.5.1 08:05:35 INFO - manifestparser == 1.1 08:05:35 INFO - mozInstall == 1.12 08:05:35 INFO - mozcrash == 0.17 08:05:35 INFO - mozdebug == 0.1 08:05:35 INFO - mozdevice == 0.48 08:05:35 INFO - mozfile == 1.2 08:05:35 INFO - mozhttpd == 0.7 08:05:35 INFO - mozinfo == 0.9 08:05:35 INFO - mozleak == 0.1 08:05:35 INFO - mozlog == 3.3 08:05:35 INFO - moznetwork == 0.27 08:05:35 INFO - mozprocess == 0.23 08:05:35 INFO - mozprofile == 0.28 08:05:35 INFO - mozrunner == 6.12 08:05:35 INFO - mozscreenshot == 0.1 08:05:35 INFO - mozsystemmonitor == 0.3 08:05:35 INFO - moztest == 0.7 08:05:35 INFO - mozversion == 1.4 08:05:35 INFO - psutil == 3.1.1 08:05:35 INFO - requests == 1.2.3 08:05:35 INFO - wsgiref == 0.1.2 08:05:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:35 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 0x288c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b3b0>, '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 0x2b4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c740>, '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': '6d15e502d8e29d5d2676d664000001c3-1470409325.720656-1414100035', '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 08:05:35 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 08:05:35 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 08:05:35 INFO - Using env: {'DISPLAY': ':0', 08:05:35 INFO - 'HOME': '/home/cltbld', 08:05:35 INFO - 'LANG': 'en_US.UTF-8', 08:05:35 INFO - 'LANGUAGE': 'en_US:en', 08:05:35 INFO - 'LOGNAME': 'cltbld', 08:05:35 INFO - 'MAIL': '/var/mail/cltbld', 08:05:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:35 INFO - 'MOZ_NO_REMOTE': '1', 08:05:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:35 INFO - 'NO_EM_RESTART': '1', 08:05:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:35 INFO - 'PWD': '/builds/slave/test', 08:05:35 INFO - 'SHELL': '/bin/bash', 08:05:35 INFO - 'SHLVL': '1', 08:05:35 INFO - 'TERM': 'linux', 08:05:35 INFO - 'TMOUT': '86400', 08:05:35 INFO - 'USER': 'cltbld', 08:05:35 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470409325.720656-1414100035', 08:05:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:35 INFO - '_': '/tools/buildbot/bin/python'} 08:05:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:35 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)) 08:05:35 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)) 08:05:35 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)) 08:05:35 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)) 08:05:35 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)) 08:05:35 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)) 08:05:35 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)) 08:05:35 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)) 08:05:35 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)) 08:05:35 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)) 08:05:35 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)) 08:05:35 INFO - Cleaning up... 08:05:35 INFO - Return code: 0 08:05:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4b3b0>, '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 0x2b4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c740>, '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': '6d15e502d8e29d5d2676d664000001c3-1470409325.720656-1414100035', '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 08:05:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:05:35 INFO - Using env: {'DISPLAY': ':0', 08:05:35 INFO - 'HOME': '/home/cltbld', 08:05:35 INFO - 'LANG': 'en_US.UTF-8', 08:05:35 INFO - 'LANGUAGE': 'en_US:en', 08:05:35 INFO - 'LOGNAME': 'cltbld', 08:05:35 INFO - 'MAIL': '/var/mail/cltbld', 08:05:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:35 INFO - 'MOZ_NO_REMOTE': '1', 08:05:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:35 INFO - 'NO_EM_RESTART': '1', 08:05:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:35 INFO - 'PWD': '/builds/slave/test', 08:05:35 INFO - 'SHELL': '/bin/bash', 08:05:35 INFO - 'SHLVL': '1', 08:05:35 INFO - 'TERM': 'linux', 08:05:35 INFO - 'TMOUT': '86400', 08:05:35 INFO - 'USER': 'cltbld', 08:05:35 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470409325.720656-1414100035', 08:05:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:35 INFO - '_': '/tools/buildbot/bin/python'} 08:05:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:05:35 INFO - Cleaning up... 08:05:35 INFO - Return code: 0 08:05:35 INFO - Running post-action listener: _resource_record_post_action 08:05:35 INFO - Running post-action listener: _start_resource_monitoring 08:05:35 INFO - Starting resource monitoring. 08:05:35 INFO - [mozharness: 2016-08-05 15:05:35.522340Z] Finished create-virtualenv step (success) 08:05:35 INFO - [mozharness: 2016-08-05 15:05:35.522841Z] Running install step. 08:05:35 INFO - Running pre-action listener: _resource_record_pre_action 08:05:35 INFO - Running main action method: install 08:05:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:05:35 INFO - Reading from file tmpfile_stdout 08:05:35 INFO - Detecting whether we're running mozinstall >=1.0... 08:05:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:05:35 INFO - Reading from file tmpfile_stdout 08:05:35 INFO - Output received: 08:05:35 INFO - Usage: mozinstall [options] installer 08:05:35 INFO - Options: 08:05:35 INFO - -h, --help show this help message and exit 08:05:35 INFO - -d DEST, --destination=DEST 08:05:35 INFO - Directory to install application into. [default: 08:05:35 INFO - "/builds/slave/test"] 08:05:35 INFO - --app=APP Application being installed. [default: firefox] 08:05:35 INFO - mkdir: /builds/slave/test/build/application 08:05:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:05:52 INFO - Reading from file tmpfile_stdout 08:05:52 INFO - Output received: 08:05:52 INFO - /builds/slave/test/build/application/firefox/firefox 08:05:52 INFO - Running post-action listener: _resource_record_post_action 08:05:52 INFO - [mozharness: 2016-08-05 15:05:52.683650Z] Finished install step (success) 08:05:52 INFO - [mozharness: 2016-08-05 15:05:52.683898Z] Running run-tests step. 08:05:52 INFO - Running pre-action listener: _resource_record_pre_action 08:05:52 INFO - Running main action method: run_tests 08:05:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:05:52 INFO - Python 2.7.3 08:05:52 INFO - Return code: 0 08:05:52 INFO - grabbing minidump binary from tooltool 08:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:05:52 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 0x2b4b3b0>, '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 0x2b4c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:05:52 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 08:05:52 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 08:05:52 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 08:05:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:05:52 INFO - Return code: 0 08:05:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:05:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:05:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:05:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:05:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:05:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M6tcCWwlTUWE7KtfM6gt9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 08:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M6tcCWwlTUWE7KtfM6gt9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 08:05:52 INFO - Using env: {'DISPLAY': ':0', 08:05:52 INFO - 'HOME': '/home/cltbld', 08:05:52 INFO - 'LANG': 'en_US.UTF-8', 08:05:52 INFO - 'LANGUAGE': 'en_US:en', 08:05:52 INFO - 'LOGNAME': 'cltbld', 08:05:52 INFO - 'MAIL': '/var/mail/cltbld', 08:05:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:05:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:52 INFO - 'MOZ_NO_REMOTE': '1', 08:05:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:52 INFO - 'NO_EM_RESTART': '1', 08:05:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:05:52 INFO - 'PWD': '/builds/slave/test', 08:05:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:05:52 INFO - 'SHELL': '/bin/bash', 08:05:52 INFO - 'SHLVL': '1', 08:05:52 INFO - 'TERM': 'linux', 08:05:52 INFO - 'TMOUT': '86400', 08:05:52 INFO - 'USER': 'cltbld', 08:05:52 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470409325.720656-1414100035', 08:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:52 INFO - '_': '/tools/buildbot/bin/python'} 08:05:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M6tcCWwlTUWE7KtfM6gt9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 08:05:52 INFO - mozversion application_buildid: 20160805063002 08:05:52 INFO - mozversion application_changeset: 192132a4cbc78fa948ad1e37c204f537043fc37e 08:05:52 INFO - mozversion application_display_name: Nightly 08:05:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:05:52 INFO - mozversion application_name: Firefox 08:05:52 INFO - mozversion application_remotingname: firefox 08:05:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 08:05:52 INFO - mozversion application_vendor: Mozilla 08:05:52 INFO - mozversion application_version: 51.0a1 08:05:52 INFO - mozversion platform_buildid: 20160805063002 08:05:52 INFO - mozversion platform_changeset: 192132a4cbc78fa948ad1e37c204f537043fc37e 08:05:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 08:05:52 INFO - mozversion platform_version: 51.0a1 08:05:52 INFO - using testdate: 1470409552 08:05:52 INFO - actual date: 1470409552 08:05:52 INFO - starting webserver on 'localhost:60209' 08:05:52 INFO - SUITE-START | Running 2 tests 08:05:52 INFO - TEST-START | dromaeo_css 08:05:52 INFO - operating with platform_type : linux_ 08:05:52 INFO - Initialising browser for dromaeo_css test... 08:05:52 INFO - TEST-INFO | started process 20993 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoiqejy/profile http://localhost:60209/getInfo.html) 08:05:56 INFO - PROCESS | 20993 | __metrics Screen width/height:1600/1200 08:05:56 INFO - PROCESS | 20993 | colorDepth:24 08:05:56 INFO - PROCESS | 20993 | Browser inner width/height: 1024/697 08:05:56 INFO - PROCESS | 20993 | __metrics 08:05:57 INFO - PROCESS | 20993 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:05:57 INFO - PROCESS | 20993 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:05:58 INFO - TEST-INFO | 20993: exit 0 08:05:58 INFO - Browser initialized. 08:05:58 INFO - Running cycle 1/1 for dromaeo_css test... 08:05:58 INFO - TEST-INFO | started process 21073 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoiqejy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:06:10 INFO - PROCESS | 21073 | RSS: Main: 156291072 08:06:10 INFO - PROCESS | 21073 | 08:07:02 INFO - PROCESS | 21073 | 1470409622191 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:09:11 INFO - PROCESS | 21073 | Cycle 1(1): loaded http://localhost:60209/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60209/tests/dromaeo/cssquery-ext.html) 08:09:12 INFO - PROCESS | 21073 | RSS: Main: 259551232 08:09:12 INFO - PROCESS | 21073 | 08:12:15 INFO - PROCESS | 21073 | Cycle 1(1): loaded http://localhost:60209/tests/dromaeo/cssquery-ext.html (next: http://localhost:60209/tests/dromaeo/cssquery-jquery.html) 08:12:15 INFO - PROCESS | 21073 | RSS: Main: 243736576 08:12:15 INFO - PROCESS | 21073 | 08:15:17 INFO - PROCESS | 21073 | Cycle 1(1): loaded http://localhost:60209/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60209/tests/dromaeo/cssquery-mootools.html) 08:15:18 INFO - PROCESS | 21073 | RSS: Main: 184111104 08:15:18 INFO - PROCESS | 21073 | 08:18:20 INFO - PROCESS | 21073 | Cycle 1(1): loaded http://localhost:60209/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60209/tests/dromaeo/cssquery-prototype.html) 08:18:21 INFO - PROCESS | 21073 | RSS: Main: 186417152 08:18:21 INFO - PROCESS | 21073 | 08:21:23 INFO - PROCESS | 21073 | Cycle 1(1): loaded http://localhost:60209/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60209/tests/dromaeo/cssquery-yui.html) 08:21:24 INFO - PROCESS | 21073 | RSS: Main: 185278464 08:21:24 INFO - PROCESS | 21073 | 08:24:27 INFO - PROCESS | 21073 | Cycle 1(1): loaded http://localhost:60209/tests/dromaeo/cssquery-yui.html (next: http://localhost:60209/tests/dromaeo/cssquery-dojo.html) 08:24:27 INFO - PROCESS | 21073 | RSS: Main: 280186880 08:24:27 INFO - PROCESS | 21073 | 08:24:27 INFO - PROCESS | 21073 | __start_tp_report 08:24:27 INFO - PROCESS | 21073 | _x_x_mozilla_page_load 08:24:27 INFO - PROCESS | 21073 | _x_x_mozilla_page_load_details 08:24:27 INFO - PROCESS | 21073 | |i|pagename|runs| 08:24:27 INFO - PROCESS | 21073 | |0;dojo.html;2983.686712895146;2992.9251768705767;3021.6525099613536;3023.017519306226;3026.6973302669735;5217.060929032773;5231.424543300234;5269.2886460327845;5295.0468915595175;5374.973125134378;5125.359330083739;5239.056969745444;5240.659357141783;5295.364556253246;5319.946800531993;4683.695559788612;4690.812367505313;4700.576948074672;4712.882177945545;4906;4861.683990540621;4862.902741945159;4867.586255168315;4885.877853053685;4908.7300198489065;4747.501512341189;4757.452892917289;4759.143354196243;4795.616350691954;4845.733484658343;4709.387779588666;4729.219678753002;4735.526447355272;4735.692180008323;4766.785494652749;4704.388429504177;4725.551072648127;4780.904381912343;4826.734529600905;4849.9030019399415;5056.924146137811;5286.180642000496;5310.787568497255;5335.946640533583;5343.572514198855;5526;5541.833744987657;5563.221149039137;5594.944050559483;5652.604317697763;5627.127795191752;5664;5678.659280443187;5683.374828768832;5695.629784064064;5174.172132458789;5223.608229382811;5293.126634105368;5293.7353132343615;5297.761600727977;5561.860953476114;5717.628354156966;5747.5114615257335;5762.94237057624;5768.307803063659;5485.424030476743;5496.1755736639025;5496.258005169331;5537.833864984057;5547.057000309957;5549.639273447213;5559.388467268678;5565.554755619541;5615.775368985195;5618.606697531215;5545.417731138173;5582.553395728413;5582.86042848932;5611.691356975324;5620.690862002547;5600.215969764236;5603.10350343943;5604.775808967677;5609.27079479665;5610.1584762285165;4220.599043090901;4299.933511298108;4302.247106756305;4343.457067866517;4383.846565370197;3868.1490072184074;3893.0656642406184;3919.7844118573753;3937.8031098445535;3945.171513982096;5348.8662783429945;5352.9732351338;5358.490943360374;5406.324209473816;5413.891722165535;5554.91667624986;5646.915296270559;5658.490735833712;5685.459881311269;5701.458361455655;5240.371155461369;5260.894782104337;5286.8942621148135;5305.098133317345;5328.094223981932;4862.756862156878;4875.317455556225;4876.561109500162;4876.878078048077;4912.263160525878;5677.630953988143;5817.331006934257;5819.418058194231;5826.563007774434;5829.7085145743395;5610.831675049755;5651.321841379061;5661.773529058792;5699.5725320600295;5720.141978703228;5898.764049437975;5909.55678324136;5910.936031514197;5911.970440147772;5913.05391137416;5385.057614917296;5586.357568879631;5596.18855265976;5603.915941260966;5621.662700237999;5543.695096769717;5572.916406253828;5584.804531841366;5617.157426385911;5676.290463692038;5463.153211252262;5475.041867673221;5479.671219726829;5493.09363954943;5497.5601951842955;5371.194320851903;5444.156155795858;5448.809291674773;5457.645253058538;5465.152901300305;5410.188471729272;5425.620206585501;5455.1544510600925;5471.23402723627;5561.499465048165;5585.469380408855;5613.831585052455;5621.606487545832;5628.437156284339;5644.209810626434;5304.681719096712;5451.809186678447;5473.343198816167;5474.863128421821;5484.588655850747 08:24:27 INFO - PROCESS | 21073 | |1;ext.html;578.7887421091303;584.6579750845755;592.1768741449386;596.7016491754123;625.4589779840438;33157.17107072324;44260.55739442605;45505;45635.54364456354;45660.77169614151;45024.874378140565;45408.545914540846;45515.54484455154;45518.544814551846;45519.31721024179;8036.758897233063;8872.73381798547;9034.68378606749;9071.319651026199;10627.415492147968;10500.109980203599;10979.945100274528;10984.121270298358;10992.395418252034;10992.890071099306;11056.502457389397;11083.667489975272;11089.611863584776;11104.389258590774;11120;10982.670519884376;10996.835047474295;11021.504032318566;11032.669019929415;11048.392338421383;10695.78608427827;10766.300190487593;10769.515371808287;10772.353658780497;10775.191860610406;42820.1435971282;43196.35205471889;43219.56780432187;43230.783846080885;43263.13473730508;3548.4854696069183;3725.068732816796;3740.869069582579;3934.9016274593077;4268.637165840907;32557.51163732546;33083.50374744381;33375.33249335024;33573.32853342944;33623.49564756531;4232.470941132358;4339.500957389909;4351.216780979423;4493.101379724036;4510.932336014929;374132;374660;375954.99999999726;376076;376513;59616.70191649101;59842;59892.401075989554;59995.40004599986;60006.69996649989;61814.38185618176;61886.38113618896;61887.6905615478;62038.689806550676;62158.68920655368;16226.269817857989;16444;16461.506154815375;16468.341266349213;16476.340946362252;12034.578789742493;12914.741705166032;13185.340732963314;13292.20246785196;13295.135816171918;16756.916215418845;16996.49010529686;17013.404530841362;17069.57326066858;17158.48524544266;5988.191594134736;6033.245844269466;6053.243344581927;6088.452039316483;6187.412195841388;897.8114595934927;991.3358050106445;1102.366139469808;1118.3290025984345;1165.3241120150292;32731.836340818143;32756.672433275362;33040.50439243413;33070.338593228;33285.50071748926;1099.8240281554913;1122.7080958950733;1156.670348950545;1181;1187.5665382135458;17026.489205323862;17307.826921730873;17325.65348693044;17387.21757520889;17389.565260868578;148307;149581;150438;150470.24764876105;151416;60091.699541502014;60294.779365444876;60320.39679603236;60326.69836650876;60496.69751651213;1227.404708716272;1349.4602159136227;1371.7599420101642;1386.286062677742;1409.4221369238562;32678.34643307073;33507.83246083754;34046.65953340534;34181.48727769036;34439.82780086083;50266.49733502618;50483;50987;51012;51070;393294;394909;396745;398327;398996;35698.46452303269;40623.187536248515;41267;41437.171256575304;42029;48258;48395.27407088967;48811.511884880696;49323.50676493333;49727.75136124296;41120;41157.1768564633;41176.38235426411;42085.57914420817;43621.345679815466;41699.7915010423;41987.7900610495;42115.368269476596;42140.578594213664;42983.570164297955;40704.59295407127;41658.79170604249;41777;42009.36985945152;42029.1594168121;35022.12444688903;36110.45834312435;37274;38368.80815595904;40908.59091409167;28043.859780700965;28269.858650706614;28441;28640;28847.5672864903 08:24:27 INFO - PROCESS | 21073 | |2;jquery.html;338.4179211755782;362.9364861149299;366.69564261662816;366.72129181821805;385.974911630744;14731.926340368296;19163;20178.991050447476;20462.590748185026;21766.673499897475;16732.916335418337;20067.59864802703;20154.589178757455;20198.091085901135;20227.696584551242;5511.862203444906;5778.768849246025;5784.82645520635;5787.508061814729;5788.247527821399;5509.531689806371;5630.5495560355275;5676.631018983753;5700.087985922253;5702.030654788675;5657.490825825675;5662.858428539278;5664.575156863231;5665.291838520185;5667.8583035424035;5527.613067085305;5624.606277560552;5642.294713160855;5649.180868774005;5684.090545512699;5019.974900125512;5021.372328458942;5022;5027.321311622957;5030.346055012861;22396;23142.88428557863;23785.643215351785;24283.63574546383;24564.877175614187;2235.519363336874;2252.481929156303;2333.1134169015836;2334.661474086248;2732.303262668027;10071.395716257048;10252.89747102527;10268.435236062014;10341.534630941625;11074.667759967213;1913;1943.4364034429998;1948.503131701407;1978.5449346650207;2000.7999200080021;61274.0808887867;66421.66789166072;78903.60548197222;88842;94825;10429.895701043044;10594.735131621772;10721.624743134109;10753.193510486744;10856.294340867818;15032;15061.623459413602;15082.321295541507;15083.190017198007;15083.773743393858;7824.804379890548;7969.242921922408;7998.440109192417;8161.387895907831;8423.831523369498;7948.721794737156;7996;8004.359651227888;8269.710560130367;8286.668533258602;4501.437320334958;4575.039241759201;4615.515370886076;4767.809287628456;4782.736949467812;1962.1268535501565;1972.142118178597;2026.2401599400225;2026.9695954560693;2043.1827269092184;853.7353420439683;910.299069716328;922.4050487435567;926.1386910173469;985.5023213277249;19535.120919558653;20308.390748277576;20371.79628203699;20412.795872041388;20603;915.8946721127155;949.3971328206638;968.5109019945023;986.2011770465946;997.9351342162736;11005.779884402267;11304.491297891615;11462.083033357312;11474.196806223485;11503.712407189887;381374;390231;486175;495683;496435;63084.36915630877;76476;90669;91672;101854.49072754588;996.9750756231152;1001.3541265883464;1022.381459217163;1035.7048241251207;1040.089921318846;18101;18118;18403.81596184021;18970.43088707341;19383.321583744502;33756.83121584376;36355.364008619144;45885.541144588125;46241.53758462372;47590.524094758606;64475.23010083874;64822;65234;65804.6709766448;66586.6670666663;8177.386695997943;8213.3429325655;8289.709860154866;8400.243978042006;8548.513010228242;11870.703232419259;13290.20258784476;13346.866531334563;13521.459141634225;13921.373538191008;11484.310941343547;11759.218830627542;11794.587189448328;11945.940270298941;12334.568290109803;10794.460276986276;11572.6528204154;11628;11640.417979100841;11807.350595717318;11331.886681133083;11681.941590291994;11785.175037747274;11792.115591330856;11879.524819007143;7493.288137626917;7781.494202876795;7937.404694647809;8224;9029.683961061332;11395.316281023164;11670.591529296435;11709.473073711533;12046.337451440255;12057.758844823229 08:24:27 INFO - PROCESS | 21073 | |3;mootools.html;1440.2654646130475;1513.0845838267846;1609.2114863716781;1755.7717496725425;1799.7480352750617;8631.568421578919;9320.067993200677;9324.347295689304;9328.253739700816;9331.44011359318;7976.800579985504;8378.832423351529;8575.742727718163;8637.697680581181;9198.678046268382;2370.715514138306;2404.422938494766;2405.7594240575977;2407;2410.927672169829;2350.74141844397;2373.6558199061124;2411.602085655865;2413.9275821725287;2415.9732113851633;2365.881705914706;2381.559411508868;2385.7375688674233;2390.8206884483648;2390.9043638254448;2299.6895419118373;2319.5013072189477;2332.4518738096617;2334.5564342774906;2335.07764433048;2328.301509547146;2338.894749736266;2342.508073304608;2342.6837376954236;2346.9295921122393;8892.199702026785;8954.686585969459;8993.685221017298;9022.368434209608;9023.909760902372;5254.658447200958;5393.514583687487;5397.649152805055;5406.270153529263;5411.161270003156;3422.709069729076;3471.7916924984584;3485.825708714554;3492.336456073338;3529.594096678889;1075.7848430313968;1087;1093.9617113400993;1098.5111625326733;1109.8224284114583;12703.491860325576;12750.87249127506;12763.170393924458;12764.234145951272;12790.872091279061;4424.823007079745;4641.396618439649;4787.61699064074;4807.903841923212;4815.686980346266;10604.204684648683;10604.734881628021;10627;10639.255252132276;10639.468026598639;5413.350397952192;5428.240046393429;5430.42980487051;5438.510534051954;5439.075357189287;4377.124575084932;4800;4872.3909511311085;4911.140550403737;5005.0240203160765;3875.612438756158;4001.3997900315185;4073.6537394321813;4075.49056367954;4090.5091389033505;1273.3378643105534;1274.6367285323638;1287.5043108403331;1292.3215311961296;1304.9217046977212;988.2489308125732;999.8700168977987;1006.0844631385404;1007.7279134633608;1012.7417508535276;5872.794452194153;6159.414855588712;6299.464545513682;6305.653189074553;6384.4254017137755;416.8603517821564;431.2840684463775;437.08212753217987;441.05834044315617;443.560874734011;3728.5898551159353;3741.607131251234;3769.3026790043928;3782.3569993101237;3791.374423220193;10991.955764202388;11375.26060806045;11448.370339631234;11505.252158609663;11556.075513958864;10814.459277036116;11260.662180134608;11510.712232194262;11515.481803318871;11521.07831373488;8397.664093436317;8567.914320856837;8581.399302048796;8601.225889669835;8601.35489838252;6121.663308517896;6168.352323006199;6171.228596425447;6244.2819075806865;6409.03864420322;10597.25819192649;10630.30902991334;10644;10662.626808061681;10755.67732967981;10233.283670143019;10615.734606634896;10706.732331691459;10707.357558546511;11003.064739496913;7342.632868356668;7850.607469626381;7861.213878612093;7986.920130798618;8008.399370047387;8850.601722922613;8985.281177505914;8991.82016359656;9009.81980360376;9024.503652299187;7889.487183333065;7896.32881205104;7929.326007289445;8121.187881211831;8181.754547363588;7789.454738168274;7828.882566761617;7913.841723165619;7990.960045199737;8002.159773223728;7390.337174135777;7417.295356941082;7504;7504.474686772092;7519.473636845369;5321.521063104339;5487.670739755467;5500.257465242141;5514.448555144453;5645.4072322405555;5289.414678724858;5394.352677678704;5462.071447853795;5476.808311709071;5531.834044978657 08:24:27 INFO - PROCESS | 21073 | |4;prototype.html;310.4102205808964;312.8138757439323;314.4763967993291;321.44550650128525;333.52472726364937;5312.893742125155;5351.25082488452;5355.4912283333115;5372.489613486718;5397.784088636459;5263.447338029509;5269;5310.548603368718;5314.282571852798;5320.095583750762;3939.2909276330247;3983.2033593281317;4115.670746340285;4174.582541745832;4195.538490766014;4155.189738001076;4157.438745769327;4165.83336666533;4170.77060761658;4192.517860446042;4113.897152571195;4117.5882411758885;4126.977780887359;4133.731307465006;4149.668026557868;3960.3465428204454;3987.4616926714957;4112.300908845504;4126.195391898581;4150.107726838714;3664.1862278172475;3666.816659167058;3668.816559172031;3669.7614655047605;3674.375356189454;5114.207297868837;5125.282460455539;5147.845564633029;5148.588112950955;5171.818986335498;4418.513963464048;4663.137319595886;4675.906481870377;4700;4740.597049250818;5458.727063646802;5481.561475081984;5487.228949380577;5494.835154945358;5505.284313039279;3923.195744872294;3927.5483319418345;3932.2528719543197;3938.72428929975;3963.8810835674976;5555.777768889239;5676.6659834938755;5683.573731970118;5688.857778555528;5765;3990.880273591739;4008.6971734186504;4012.0371110933747;4041.959580404217;4057.411675307064;4071.6742660587083;4092.529359123679;4097.75018619324;4105.609967053125;4109.753414795062;4570.565796249351;4590.6228131561065;4660.3688708951595;4663.230566956482;4665.883352916137;5483.1227003680015;5486.177073439016;5493.560515158778;5518.558515318845;5548.69482178476;1369.5275130080106;1383.481194552043;1387.1330418488444;1388.3544151969384;1391.1444461656008;845.754731127966;866.3415803988888;905;919.6091661044029;925.1534845616186;5143.562797162208;5321.574274058144;5333.813316533902;5355.7054362009685;5359.839204823784;5655.236543066633;5673.553243922774;5685.891251205975;5686.829395118153;5709.800156994485;5094;5337.412884582693;5392.433794451605;5394.352677678704;5415.48552887475;2955.349823038928;3012.584085479821;3023.8488075596133;3024.1834704629628;3024.682408347092;5921.496672782776;5935.52515798735;5937.6734279614175;5943.58394912352;5947.345791962881;5581.302337207849;5725.341585717612;5734.455226753452;5740.564858785304;5759.971200143972;5841.714822738991;5867.794627188114;5883.675723216369;5886.352501224862;5934.6142500737315;5410.891782164414;5638.984982702988;5665.773369065356;5668.603197776116;5702.543796496353;5572.693501857275;5620.297462817148;5634.267545219095;5677.914831277617;5698.091139468324;5794.783095549813;5863.2670916135485;5891.823245302648;5927.199828023162;5932.970335148297;3920.6471417572557;4020.698447616382;4031.6976226783695;4082.4692789937117;4092.386142078593;5661.490465858093;5701.287339082614;5705.144228365778;5710.915515836773;5764.221830052889;5527.613067085426;5670.234518339971;5685;5685.943140568541;5690.857728556819;5566.443355664401;5574.554035677217;5575.1915972183;5584.078627026495;5593.804216852391;5475.835724928259;5489.258950041853;5489.3687225969525;5520.475554822286;5534.667919924817;5386.703731294817;5390.730463476732;5553.777848885999;5565.66424058215;5572.219889215432;5469.0740453857;5493.395726470165;5499.230107784993;5502.58730595199;5512.877542146222 08:24:27 INFO - PROCESS | 21073 | |5;yui.html;748.3227678950549;770.3375097416225;798.3373799746212;804.9235322644347;846.1496196322695;15331.770023449642;16626.83373166268;16678.249478773454;16689.91655041726;16704.665906681857;15512.922435387836;15720.37118515261;15722.135282559455;15730.977486463373;15746.133962632051;652.6540933305356;774.0865778381508;785.8585454618167;806.4999700185864;814.6578437056421;814.5723495165056;817.5707753429438;819.4345901328064;821.7165078048064;822.5188264865061;867.7266661001796;869.1308691308691;869.7869022089596;870.0777176193255;870.1168314161132;700.2402393403164;863.3481721300441;863.848826455371;864.3344624638993;864.576357584782;612.13077430049;631.7757196195377;638.7540796793268;638.7796210307437;638.9488840892717;14057.367418466194;14099.36552855124;14102.083364581373;14105.294735263298;14139.222342771143;13637.931810340884;14309.642258943506;14562.199079050648;14656.633584160374;14730.852691473163;13539.661508462368;13599.04700451682;13688.794668079987;13699.45202191911;14068.859311406857;4449.859827434193;4513.187626227278;4514.906770365932;4518.615917647004;4527.230370836965;85765.57117214374;85865;87864;88784.11215887759;90487;10255.58977640886;10718.785624287471;11606.88393116058;11863.88136118645;11906.345151016603;23275.650865237036;23322;23398.415039623804;23444;23444.296671099895;8659.220670139717;8778.122187781171;8812.471251724917;8874.29005679544;9055.59249833759;4672.724457121763;4746.121967436035;4766.142094423037;4820.807167713322;4979.029089327619;3609.819509024538;3710.128119891823;3715.4241092630687;3717.9628203718157;3728.5339332583426;609.2297312046665;620.5912578446901;621.7109044294425;630.3003665930813;644.7839973608893;675.9831004224835;686.7424715731601;713.9500234983501;714.3820595185127;724.9891251631229;8712.607932643046;9088.272938164931;9276.953615231881;9310.767230819283;9392.938936973871;681.3867519232631;683.6103421049954;698.2458944340101;707.306839297481;707.5118168463744;4407.537208593116;4549.6360291176625;4603.95396046042;4626.6007100969055;4647.279671650899;74379;76427.61786191145;101282.49358753307;123540;130276.3486182563;69287.3071269291;108832.4558377203;114323;115355;116743;72357;98384;98867;102208.48895755623;103729.48135259426;8472.788180295542;8512.489250644981;8560.91439085626;8663.306935445275;9027.187553120251;58818.41181588129;59561.40438595558;60122.36899187774;60528;62124;83416.58291708502;85769.14230857612;86823;87710.56144719491;90577.54711226402;11797.587084452003;11884.82172767392;12080.51677932908;12172.452239649414;12219.900208981235;12192;12451.252924824177;12748.61754147377;12764.489420423079;12911;12088.39558022113;12097.818532722193;12232.87767122353;12545.31000794965;12919.817104956019;10960.616378426717;11055.447227638426;11189.72025699364;11518.539258429904;11579.652610421701;11543.36511491876;11861.110416718953;11879.58421455245;11980.28118312904;12164.39178041112;9752;10040.447775372424;10063.29556931037;10291.073803357735;10463.68608941733;9439.905600943903;9819.754506137404;9845.113939745457;9856.112949834549;9905.55425005862 08:24:27 INFO - PROCESS | 21073 | __end_tp_report 08:24:27 INFO - PROCESS | 21073 | __start_cc_report 08:24:27 INFO - PROCESS | 21073 | _x_x_mozilla_cycle_collect,1096 08:24:27 INFO - PROCESS | 21073 | __end_cc_report 08:24:27 INFO - PROCESS | 21073 | __startTimestamp1470410667455__endTimestamp 08:24:27 INFO - PROCESS | 21073 | 08:24:27 INFO - PROCESS | 21073 | ------- Summary: start ------- 08:24:27 INFO - PROCESS | 21073 | Number of tests: 6 08:24:27 INFO - PROCESS | 21073 | 08:24:27 INFO - PROCESS | 21073 | [#0] dojo.html Cycles:165 Average:5230.10 Median:5451.81 stddev:592.67 (10.9%) stddev-sans-first:567.68 08:24:27 INFO - PROCESS | 21073 | Values: 2983.7 2992.9 3021.7 3023.0 3026.7 5217.1 5231.4 5269.3 5295.0 5375.0 5125.4 5239.1 5240.7 5295.4 5319.9 4683.7 4690.8 4700.6 4712.9 4906.0 4861.7 4862.9 4867.6 4885.9 4908.7 4747.5 4757.5 4759.1 4795.6 4845.7 4709.4 4729.2 4735.5 4735.7 4766.8 4704.4 4725.6 4780.9 4826.7 4849.9 5056.9 5286.2 5310.8 5335.9 5343.6 5526.0 5541.8 5563.2 5594.9 5652.6 5627.1 5664.0 5678.7 5683.4 5695.6 5174.2 5223.6 5293.1 5293.7 5297.8 5561.9 5717.6 5747.5 5762.9 5768.3 5485.4 5496.2 5496.3 5537.8 5547.1 5549.6 5559.4 5565.6 5615.8 5618.6 5545.4 5582.6 5582.9 5611.7 5620.7 5600.2 5603.1 5604.8 5609.3 5610.2 4220.6 4299.9 4302.2 4343.5 4383.8 3868.1 3893.1 3919.8 3937.8 3945.2 5348.9 5353.0 5358.5 5406.3 5413.9 5554.9 5646.9 5658.5 5685.5 5701.5 5240.4 5260.9 5286.9 5305.1 5328.1 4862.8 4875.3 4876.6 4876.9 4912.3 5677.6 5817.3 5819.4 5826.6 5829.7 5610.8 5651.3 5661.8 5699.6 5720.1 5898.8 5909.6 5910.9 5912.0 5913.1 5385.1 5586.4 5596.2 5603.9 5621.7 5543.7 5572.9 5584.8 5617.2 5676.3 5463.2 5475.0 5479.7 5493.1 5497.6 5371.2 5444.2 5448.8 5457.6 5465.2 5410.2 5425.6 5455.2 5471.2 5561.5 5585.5 5613.8 5621.6 5628.4 5644.2 5304.7 5451.8 5473.3 5474.9 5484.6 08:24:27 INFO - PROCESS | 21073 | 08:24:27 INFO - PROCESS | 21073 | [#1] ext.html Cycles:180 Average:50054.65 Median:376294.50 stddev:86261.72 (22.9%) stddev-sans-first:86423.72 08:24:27 INFO - PROCESS | 21073 | Values: 578.8 584.7 592.2 596.7 625.5 33157.2 44260.6 45505.0 45635.5 45660.8 45024.9 45408.5 45515.5 45518.5 45519.3 8036.8 8872.7 9034.7 9071.3 10627.4 10500.1 10979.9 10984.1 10992.4 10992.9 11056.5 11083.7 11089.6 11104.4 11120.0 10982.7 10996.8 11021.5 11032.7 11048.4 10695.8 10766.3 10769.5 10772.4 10775.2 42820.1 43196.4 43219.6 43230.8 43263.1 3548.5 3725.1 3740.9 3934.9 4268.6 32557.5 33083.5 33375.3 33573.3 33623.5 4232.5 4339.5 4351.2 4493.1 4510.9 374132.0 374660.0 375955.0 376076.0 376513.0 59616.7 59842.0 59892.4 59995.4 60006.7 61814.4 61886.4 61887.7 62038.7 62158.7 16226.3 16444.0 16461.5 16468.3 16476.3 12034.6 12914.7 13185.3 13292.2 13295.1 16756.9 16996.5 17013.4 17069.6 17158.5 5988.2 6033.2 6053.2 6088.5 6187.4 897.8 991.3 1102.4 1118.3 1165.3 32731.8 32756.7 33040.5 33070.3 33285.5 1099.8 1122.7 1156.7 1181.0 1187.6 17026.5 17307.8 17325.7 17387.2 17389.6 148307.0 149581.0 150438.0 150470.2 151416.0 60091.7 60294.8 60320.4 60326.7 60496.7 1227.4 1349.5 1371.8 1386.3 1409.4 32678.3 33507.8 34046.7 34181.5 34439.8 50266.5 50483.0 50987.0 51012.0 51070.0 393294.0 394909.0 396745.0 398327.0 398996.0 35698.5 40623.2 41267.0 41437.2 42029.0 48258.0 48395.3 48811.5 49323.5 49727.8 41120.0 41157.2 41176.4 42085.6 43621.3 41699.8 41987.8 42115.4 42140.6 42983.6 40704.6 41658.8 41777.0 42009.4 42029.2 35022.1 36110.5 37274.0 38368.8 40908.6 28043.9 28269.9 28441.0 28640.0 28847.6 08:24:27 INFO - PROCESS | 21073 | 08:24:27 INFO - PROCESS | 21073 | [#2] jquery.html Cycles:180 Average:27871.95 Median:17047.62 stddev:74893.69 (439.3%) stddev-sans-first:75075.26 08:24:27 INFO - PROCESS | 21073 | Values: 338.4 362.9 366.7 366.7 386.0 14731.9 19163.0 20179.0 20462.6 21766.7 16732.9 20067.6 20154.6 20198.1 20227.7 5511.9 5778.8 5784.8 5787.5 5788.2 5509.5 5630.5 5676.6 5700.1 5702.0 5657.5 5662.9 5664.6 5665.3 5667.9 5527.6 5624.6 5642.3 5649.2 5684.1 5020.0 5021.4 5022.0 5027.3 5030.3 22396.0 23142.9 23785.6 24283.6 24564.9 2235.5 2252.5 2333.1 2334.7 2732.3 10071.4 10252.9 10268.4 10341.5 11074.7 1913.0 1943.4 1948.5 1978.5 2000.8 61274.1 66421.7 78903.6 88842.0 94825.0 10429.9 10594.7 10721.6 10753.2 10856.3 15032.0 15061.6 15082.3 15083.2 15083.8 7824.8 7969.2 7998.4 8161.4 8423.8 7948.7 7996.0 8004.4 8269.7 8286.7 4501.4 4575.0 4615.5 4767.8 4782.7 1962.1 1972.1 2026.2 2027.0 2043.2 853.7 910.3 922.4 926.1 985.5 19535.1 20308.4 20371.8 20412.8 20603.0 915.9 949.4 968.5 986.2 997.9 11005.8 11304.5 11462.1 11474.2 11503.7 381374.0 390231.0 486175.0 495683.0 496435.0 63084.4 76476.0 90669.0 91672.0 101854.5 997.0 1001.4 1022.4 1035.7 1040.1 18101.0 18118.0 18403.8 18970.4 19383.3 33756.8 36355.4 45885.5 46241.5 47590.5 64475.2 64822.0 65234.0 65804.7 66586.7 8177.4 8213.3 8289.7 8400.2 8548.5 11870.7 13290.2 13346.9 13521.5 13921.4 11484.3 11759.2 11794.6 11945.9 12334.6 10794.5 11572.7 11628.0 11640.4 11807.4 11331.9 11681.9 11785.2 11792.1 11879.5 7493.3 7781.5 7937.4 8224.0 9029.7 11395.3 11670.6 11709.5 12046.3 12057.8 08:24:27 INFO - PROCESS | 21073 | 08:24:27 INFO - PROCESS | 21073 | [#3] mootools.html Cycles:180 Average:5972.35 Median:2407.10 stddev:3463.13 (143.9%) stddev-sans-first:3456.09 08:24:27 INFO - PROCESS | 21073 | Values: 1440.3 1513.1 1609.2 1755.8 1799.7 8631.6 9320.1 9324.3 9328.3 9331.4 7976.8 8378.8 8575.7 8637.7 9198.7 2370.7 2404.4 2405.8 2407.0 2410.9 2350.7 2373.7 2411.6 2413.9 2416.0 2365.9 2381.6 2385.7 2390.8 2390.9 2299.7 2319.5 2332.5 2334.6 2335.1 2328.3 2338.9 2342.5 2342.7 2346.9 8892.2 8954.7 8993.7 9022.4 9023.9 5254.7 5393.5 5397.6 5406.3 5411.2 3422.7 3471.8 3485.8 3492.3 3529.6 1075.8 1087.0 1094.0 1098.5 1109.8 12703.5 12750.9 12763.2 12764.2 12790.9 4424.8 4641.4 4787.6 4807.9 4815.7 10604.2 10604.7 10627.0 10639.3 10639.5 5413.4 5428.2 5430.4 5438.5 5439.1 4377.1 4800.0 4872.4 4911.1 5005.0 3875.6 4001.4 4073.7 4075.5 4090.5 1273.3 1274.6 1287.5 1292.3 1304.9 988.2 999.9 1006.1 1007.7 1012.7 5872.8 6159.4 6299.5 6305.7 6384.4 416.9 431.3 437.1 441.1 443.6 3728.6 3741.6 3769.3 3782.4 3791.4 10992.0 11375.3 11448.4 11505.3 11556.1 10814.5 11260.7 11510.7 11515.5 11521.1 8397.7 8567.9 8581.4 8601.2 8601.4 6121.7 6168.4 6171.2 6244.3 6409.0 10597.3 10630.3 10644.0 10662.6 10755.7 10233.3 10615.7 10706.7 10707.4 11003.1 7342.6 7850.6 7861.2 7986.9 8008.4 8850.6 8985.3 8991.8 9009.8 9024.5 7889.5 7896.3 7929.3 8121.2 8181.8 7789.5 7828.9 7913.8 7991.0 8002.2 7390.3 7417.3 7504.0 7504.5 7519.5 5321.5 5487.7 5500.3 5514.4 5645.4 5289.4 5394.4 5462.1 5476.8 5531.8 08:24:27 INFO - PROCESS | 21073 | 08:24:27 INFO - PROCESS | 21073 | [#4] prototype.html Cycles:180 Average:4665.08 Median:5379.60 stddev:1383.47 (25.7%) stddev-sans-first:1348.19 08:24:27 INFO - PROCESS | 21073 | Values: 310.4 312.8 314.5 321.4 333.5 5312.9 5351.3 5355.5 5372.5 5397.8 5263.4 5269.0 5310.5 5314.3 5320.1 3939.3 3983.2 4115.7 4174.6 4195.5 4155.2 4157.4 4165.8 4170.8 4192.5 4113.9 4117.6 4127.0 4133.7 4149.7 3960.3 3987.5 4112.3 4126.2 4150.1 3664.2 3666.8 3668.8 3669.8 3674.4 5114.2 5125.3 5147.8 5148.6 5171.8 4418.5 4663.1 4675.9 4700.0 4740.6 5458.7 5481.6 5487.2 5494.8 5505.3 3923.2 3927.5 3932.3 3938.7 3963.9 5555.8 5676.7 5683.6 5688.9 5765.0 3990.9 4008.7 4012.0 4042.0 4057.4 4071.7 4092.5 4097.8 4105.6 4109.8 4570.6 4590.6 4660.4 4663.2 4665.9 5483.1 5486.2 5493.6 5518.6 5548.7 1369.5 1383.5 1387.1 1388.4 1391.1 845.8 866.3 905.0 919.6 925.2 5143.6 5321.6 5333.8 5355.7 5359.8 5655.2 5673.6 5685.9 5686.8 5709.8 5094.0 5337.4 5392.4 5394.4 5415.5 2955.3 3012.6 3023.8 3024.2 3024.7 5921.5 5935.5 5937.7 5943.6 5947.3 5581.3 5725.3 5734.5 5740.6 5760.0 5841.7 5867.8 5883.7 5886.4 5934.6 5410.9 5639.0 5665.8 5668.6 5702.5 5572.7 5620.3 5634.3 5677.9 5698.1 5794.8 5863.3 5891.8 5927.2 5933.0 3920.6 4020.7 4031.7 4082.5 4092.4 5661.5 5701.3 5705.1 5710.9 5764.2 5527.6 5670.2 5685.0 5685.9 5690.9 5566.4 5574.6 5575.2 5584.1 5593.8 5475.8 5489.3 5489.4 5520.5 5534.7 5386.7 5390.7 5553.8 5565.7 5572.2 5469.1 5493.4 5499.2 5502.6 5512.9 08:24:27 INFO - PROCESS | 21073 | 08:24:27 INFO - PROCESS | 21073 | [#5] yui.html Cycles:180 Average:21555.15 Median:4793.47 stddev:31915.37 (665.8%) stddev-sans-first:31966.67 08:24:27 INFO - PROCESS | 21073 | Values: 748.3 770.3 798.3 804.9 846.1 15331.8 16626.8 16678.2 16689.9 16704.7 15512.9 15720.4 15722.1 15731.0 15746.1 652.7 774.1 785.9 806.5 814.7 814.6 817.6 819.4 821.7 822.5 867.7 869.1 869.8 870.1 870.1 700.2 863.3 863.8 864.3 864.6 612.1 631.8 638.8 638.8 638.9 14057.4 14099.4 14102.1 14105.3 14139.2 13637.9 14309.6 14562.2 14656.6 14730.9 13539.7 13599.0 13688.8 13699.5 14068.9 4449.9 4513.2 4514.9 4518.6 4527.2 85765.6 85865.0 87864.0 88784.1 90487.0 10255.6 10718.8 11606.9 11863.9 11906.3 23275.7 23322.0 23398.4 23444.0 23444.3 8659.2 8778.1 8812.5 8874.3 9055.6 4672.7 4746.1 4766.1 4820.8 4979.0 3609.8 3710.1 3715.4 3718.0 3728.5 609.2 620.6 621.7 630.3 644.8 676.0 686.7 714.0 714.4 725.0 8712.6 9088.3 9277.0 9310.8 9392.9 681.4 683.6 698.2 707.3 707.5 4407.5 4549.6 4604.0 4626.6 4647.3 74379.0 76427.6 101282.5 123540.0 130276.3 69287.3 108832.5 114323.0 115355.0 116743.0 72357.0 98384.0 98867.0 102208.5 103729.5 8472.8 8512.5 8560.9 8663.3 9027.2 58818.4 59561.4 60122.4 60528.0 62124.0 83416.6 85769.1 86823.0 87710.6 90577.5 11797.6 11884.8 12080.5 12172.5 12219.9 12192.0 12451.3 12748.6 12764.5 12911.0 12088.4 12097.8 12232.9 12545.3 12919.8 10960.6 11055.4 11189.7 11518.5 11579.7 11543.4 11861.1 11879.6 11980.3 12164.4 9752.0 10040.4 10063.3 10291.1 10463.7 9439.9 9819.8 9845.1 9856.1 9905.6 08:24:27 INFO - PROCESS | 21073 | -------- Summary: end -------- 08:24:27 INFO - PROCESS | 21073 | 08:24:28 INFO - TEST-INFO | 21073: exit 0 08:24:28 INFO - TEST-OK | dromaeo_css | took 1115228ms 08:24:28 INFO - TEST-START | kraken 08:24:28 INFO - operating with platform_type : linux_ 08:24:28 INFO - Initialising browser for kraken test... 08:24:28 INFO - TEST-INFO | started process 21381 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpljlkmA/profile http://localhost:60209/getInfo.html) 08:24:32 INFO - PROCESS | 21381 | __metrics Screen width/height:1600/1200 08:24:32 INFO - PROCESS | 21381 | colorDepth:24 08:24:32 INFO - PROCESS | 21381 | Browser inner width/height: 1024/697 08:24:32 INFO - PROCESS | 21381 | __metrics 08:24:32 INFO - PROCESS | 21381 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:24:32 INFO - PROCESS | 21381 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:24:33 INFO - TEST-INFO | 21381: exit 0 08:24:33 INFO - Browser initialized. 08:24:33 INFO - Running cycle 1/1 for kraken test... 08:24:33 INFO - TEST-INFO | started process 21466 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpljlkmA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:24:45 INFO - PROCESS | 21466 | RSS: Main: 156229632 08:24:45 INFO - PROCESS | 21466 | 08:24:48 INFO - PROCESS | 21466 | Cycle 1(1): loaded http://localhost:60209/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60209/tests/kraken/driver.html?testName=audio-beat-detection) 08:24:48 INFO - PROCESS | 21466 | RSS: Main: 213098496 08:24:48 INFO - PROCESS | 21466 | 08:24:51 INFO - PROCESS | 21466 | Cycle 1(1): loaded http://localhost:60209/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60209/tests/kraken/driver.html?testName=audio-dft) 08:24:52 INFO - PROCESS | 21466 | RSS: Main: 191664128 08:24:52 INFO - PROCESS | 21466 | 08:24:55 INFO - PROCESS | 21466 | Cycle 1(1): loaded http://localhost:60209/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60209/tests/kraken/driver.html?testName=audio-fft) 08:24:55 INFO - PROCESS | 21466 | RSS: Main: 269283328 08:24:55 INFO - PROCESS | 21466 | 08:24:57 INFO - PROCESS | 21466 | Cycle 1(1): loaded http://localhost:60209/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60209/tests/kraken/driver.html?testName=audio-oscillator) 08:24:58 INFO - PROCESS | 21466 | RSS: Main: 179834880 08:24:58 INFO - PROCESS | 21466 | 08:25:00 INFO - PROCESS | 21466 | Cycle 1(1): loaded http://localhost:60209/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60209/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:25:01 INFO - PROCESS | 21466 | RSS: Main: 184381440 08:25:01 INFO - PROCESS | 21466 | 08:25:04 INFO - PROCESS | 21466 | Cycle 1(1): loaded http://localhost:60209/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60209/tests/kraken/driver.html?testName=imaging-darkroom) 08:25:04 INFO - PROCESS | 21466 | RSS: Main: 218935296 08:25:04 INFO - PROCESS | 21466 | 08:25:08 INFO - PROCESS | 21466 | Cycle 1(1): loaded http://localhost:60209/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60209/tests/kraken/driver.html?testName=imaging-desaturate) 08:25:08 INFO - PROCESS | 21466 | RSS: Main: 219860992 08:25:08 INFO - PROCESS | 21466 | 08:25:11 INFO - PROCESS | 21466 | Cycle 1(1): loaded http://localhost:60209/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60209/tests/kraken/driver.html?testName=json-parse-financial) 08:25:12 INFO - PROCESS | 21466 | RSS: Main: 219930624 08:25:12 INFO - PROCESS | 21466 | 08:25:13 INFO - PROCESS | 21466 | Cycle 1(1): loaded http://localhost:60209/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60209/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:25:14 INFO - PROCESS | 21466 | RSS: Main: 183705600 08:25:14 INFO - PROCESS | 21466 | 08:25:15 INFO - PROCESS | 21466 | Cycle 1(1): loaded http://localhost:60209/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60209/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:25:16 INFO - PROCESS | 21466 | RSS: Main: 189063168 08:25:16 INFO - PROCESS | 21466 | 08:25:18 INFO - PROCESS | 21466 | Cycle 1(1): loaded http://localhost:60209/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60209/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:25:19 INFO - PROCESS | 21466 | RSS: Main: 194113536 08:25:19 INFO - PROCESS | 21466 | 08:25:21 INFO - PROCESS | 21466 | Cycle 1(1): loaded http://localhost:60209/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60209/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:25:22 INFO - PROCESS | 21466 | RSS: Main: 194330624 08:25:22 INFO - PROCESS | 21466 | 08:25:25 INFO - PROCESS | 21466 | Cycle 1(1): loaded http://localhost:60209/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60209/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:25:25 INFO - PROCESS | 21466 | RSS: Main: 197042176 08:25:25 INFO - PROCESS | 21466 | 08:25:27 INFO - PROCESS | 21466 | Cycle 1(1): loaded http://localhost:60209/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60209/tests/kraken/driver.html?testName=ai-astar) 08:25:27 INFO - PROCESS | 21466 | RSS: Main: 243675136 08:25:27 INFO - PROCESS | 21466 | 08:25:27 INFO - PROCESS | 21466 | __start_tp_report 08:25:27 INFO - PROCESS | 21466 | _x_x_mozilla_page_load 08:25:27 INFO - PROCESS | 21466 | _x_x_mozilla_page_load_details 08:25:27 INFO - PROCESS | 21466 | |i|pagename|runs| 08:25:27 INFO - PROCESS | 21466 | |0;ai-astar;100;111;112;110;114;111;111;112;111;111 08:25:27 INFO - PROCESS | 21466 | |1;audio-beat-detection;144;116;121;187;119;123;140;117;155;117 08:25:27 INFO - PROCESS | 21466 | |2;audio-dft;162;159;161;160;159;161;161;160;159;161 08:25:27 INFO - PROCESS | 21466 | |3;audio-fft;73;75;74;107;74;75;75;75;99;74 08:25:27 INFO - PROCESS | 21466 | |4;audio-oscillator;84;84;126;84;85;84;123;83;84;129 08:25:27 INFO - PROCESS | 21466 | |5;imaging-gaussian-blur;116;117;117;116;116;117;117;116;117;118 08:25:27 INFO - PROCESS | 21466 | |6;imaging-darkroom;153;146;145;145;145;146;145;145;145;145 08:25:27 INFO - PROCESS | 21466 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 08:25:27 INFO - PROCESS | 21466 | |8;json-parse-financial;51;51;50;51;49;50;49;50;51;50 08:25:27 INFO - PROCESS | 21466 | |9;json-stringify-tinderbox;62;62;62;62;62;62;62;62;62;63 08:25:27 INFO - PROCESS | 21466 | |10;stanford-crypto-aes;75;76;75;81;74;76;81;75;75;75 08:25:27 INFO - PROCESS | 21466 | |11;stanford-crypto-ccm;136;131;122;120;122;129;119;132;132;123 08:25:27 INFO - PROCESS | 21466 | |12;stanford-crypto-pbkdf2;158;162;165;158;159;162;158;158;161;158 08:25:27 INFO - PROCESS | 21466 | |13;stanford-crypto-sha256-iterative;64;66;63;63;64;64;62;63;62;68 08:25:27 INFO - PROCESS | 21466 | __end_tp_report 08:25:27 INFO - PROCESS | 21466 | __start_cc_report 08:25:27 INFO - PROCESS | 21466 | _x_x_mozilla_cycle_collect,1622 08:25:27 INFO - PROCESS | 21466 | __end_cc_report 08:25:27 INFO - PROCESS | 21466 | __startTimestamp1470410727655__endTimestamp 08:25:27 INFO - PROCESS | 21466 | 08:25:27 INFO - PROCESS | 21466 | ------- Summary: start ------- 08:25:27 INFO - PROCESS | 21466 | Number of tests: 14 08:25:27 INFO - PROCESS | 21466 | 08:25:27 INFO - PROCESS | 21466 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:3.77 (3.4%) stddev-sans-first:1.13 08:25:27 INFO - PROCESS | 21466 | Values: 100.0 111.0 112.0 110.0 114.0 111.0 111.0 112.0 111.0 111.0 08:25:27 INFO - PROCESS | 21466 | 08:25:27 INFO - PROCESS | 21466 | [#1] audio-beat-detection Cycles:10 Average:133.90 Median:131.50 stddev:23.10 (17.6%) stddev-sans-first:24.21 08:25:27 INFO - PROCESS | 21466 | Values: 144.0 116.0 121.0 187.0 119.0 123.0 140.0 117.0 155.0 117.0 08:25:27 INFO - PROCESS | 21466 | 08:25:27 INFO - PROCESS | 21466 | [#2] audio-dft Cycles:10 Average:160.30 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:0.93 08:25:27 INFO - PROCESS | 21466 | Values: 162.0 159.0 161.0 160.0 159.0 161.0 161.0 160.0 159.0 161.0 08:25:27 INFO - PROCESS | 21466 | 08:25:27 INFO - PROCESS | 21466 | [#3] audio-fft Cycles:10 Average:80.10 Median:75.00 stddev:12.23 (16.3%) stddev-sans-first:12.70 08:25:27 INFO - PROCESS | 21466 | Values: 73.0 75.0 74.0 107.0 74.0 75.0 75.0 75.0 99.0 74.0 08:25:27 INFO - PROCESS | 21466 | 08:25:27 INFO - PROCESS | 21466 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:84.00 stddev:20.34 (24.2%) stddev-sans-first:21.06 08:25:27 INFO - PROCESS | 21466 | Values: 84.0 84.0 126.0 84.0 85.0 84.0 123.0 83.0 84.0 129.0 08:25:27 INFO - PROCESS | 21466 | 08:25:27 INFO - PROCESS | 21466 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 08:25:27 INFO - PROCESS | 21466 | Values: 116.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 117.0 118.0 08:25:27 INFO - PROCESS | 21466 | 08:25:27 INFO - PROCESS | 21466 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:145.00 stddev:2.49 (1.7%) stddev-sans-first:0.44 08:25:27 INFO - PROCESS | 21466 | Values: 153.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 145.0 08:25:27 INFO - PROCESS | 21466 | 08:25:27 INFO - PROCESS | 21466 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 08:25:27 INFO - PROCESS | 21466 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 08:25:27 INFO - PROCESS | 21466 | 08:25:27 INFO - PROCESS | 21466 | [#8] json-parse-financial Cycles:10 Average:50.20 Median:50.50 stddev:0.79 (1.6%) stddev-sans-first:0.78 08:25:27 INFO - PROCESS | 21466 | Values: 51.0 51.0 50.0 51.0 49.0 50.0 49.0 50.0 51.0 50.0 08:25:27 INFO - PROCESS | 21466 | 08:25:27 INFO - PROCESS | 21466 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 08:25:27 INFO - PROCESS | 21466 | Values: 62.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 63.0 08:25:27 INFO - PROCESS | 21466 | 08:25:27 INFO - PROCESS | 21466 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:75.50 stddev:2.54 (3.4%) stddev-sans-first:2.65 08:25:27 INFO - PROCESS | 21466 | Values: 75.0 76.0 75.0 81.0 74.0 76.0 81.0 75.0 75.0 75.0 08:25:27 INFO - PROCESS | 21466 | 08:25:27 INFO - PROCESS | 21466 | [#11] stanford-crypto-ccm Cycles:10 Average:126.60 Median:130.00 stddev:6.04 (4.6%) stddev-sans-first:5.36 08:25:27 INFO - PROCESS | 21466 | Values: 136.0 131.0 122.0 120.0 122.0 129.0 119.0 132.0 132.0 123.0 08:25:27 INFO - PROCESS | 21466 | 08:25:27 INFO - PROCESS | 21466 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.90 Median:160.00 stddev:2.47 (1.5%) stddev-sans-first:2.52 08:25:27 INFO - PROCESS | 21466 | Values: 158.0 162.0 165.0 158.0 159.0 162.0 158.0 158.0 161.0 158.0 08:25:27 INFO - PROCESS | 21466 | 08:25:27 INFO - PROCESS | 21466 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:1.85 (2.9%) stddev-sans-first:1.96 08:25:27 INFO - PROCESS | 21466 | Values: 64.0 66.0 63.0 63.0 64.0 64.0 62.0 63.0 62.0 68.0 08:25:27 INFO - PROCESS | 21466 | -------- Summary: end -------- 08:25:27 INFO - PROCESS | 21466 | 08:25:28 INFO - TEST-INFO | 21466: exit 0 08:25:28 INFO - TEST-OK | kraken | took 60554ms 08:25:28 INFO - SUITE-END | took 1175s 08:25:28 INFO - Completed test suite (00:19:35) 08:25:28 INFO - javascript benchmark 08:25:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2983.686712895146, 2992.9251768705767, 3021.6525099613536, 3023.017519306226, 3026.6973302669735, 5217.060929032773, 5231.424543300234, 5269.2886460327845, 5295.0468915595175, 5374.973125134378, 5125.359330083739, 5239.056969745444, 5240.659357141783, 5295.364556253246, 5319.946800531993, 4683.695559788612, 4690.812367505313, 4700.576948074672, 4712.882177945545, 4906.0, 4861.683990540621, 4862.902741945159, 4867.586255168315, 4885.877853053685, 4908.7300198489065, 4747.501512341189, 4757.452892917289, 4759.143354196243, 4795.616350691954, 4845.733484658343, 4709.387779588666, 4729.219678753002, 4735.526447355272, 4735.692180008323, 4766.785494652749, 4704.388429504177, 4725.551072648127, 4780.904381912343, 4826.734529600905, 4849.9030019399415, 5056.924146137811, 5286.180642000496, 5310.787568497255, 5335.946640533583, 5343.572514198855, 5526.0, 5541.833744987657, 5563.221149039137, 5594.944050559483, 5652.604317697763, 5627.127795191752, 5664.0, 5678.659280443187, 5683.374828768832, 5695.629784064064, 5174.172132458789, 5223.608229382811, 5293.126634105368, 5293.7353132343615, 5297.761600727977, 5561.860953476114, 5717.628354156966, 5747.5114615257335, 5762.94237057624, 5768.307803063659, 5485.424030476743, 5496.1755736639025, 5496.258005169331, 5537.833864984057, 5547.057000309957, 5549.639273447213, 5559.388467268678, 5565.554755619541, 5615.775368985195, 5618.606697531215, 5545.417731138173, 5582.553395728413, 5582.86042848932, 5611.691356975324, 5620.690862002547, 5600.215969764236, 5603.10350343943, 5604.775808967677, 5609.27079479665, 5610.1584762285165, 4220.599043090901, 4299.933511298108, 4302.247106756305, 4343.457067866517, 4383.846565370197, 3868.1490072184074, 3893.0656642406184, 3919.7844118573753, 3937.8031098445535, 3945.171513982096, 5348.8662783429945, 5352.9732351338, 5358.490943360374, 5406.324209473816, 5413.891722165535, 5554.91667624986, 5646.915296270559, 5658.490735833712, 5685.459881311269, 5701.458361455655, 5240.371155461369, 5260.894782104337, 5286.8942621148135, 5305.098133317345, 5328.094223981932, 4862.756862156878, 4875.317455556225, 4876.561109500162, 4876.878078048077, 4912.263160525878, 5677.630953988143, 5817.331006934257, 5819.418058194231, 5826.563007774434, 5829.7085145743395, 5610.831675049755, 5651.321841379061, 5661.773529058792, 5699.5725320600295, 5720.141978703228, 5898.764049437975, 5909.55678324136, 5910.936031514197, 5911.970440147772, 5913.05391137416, 5385.057614917296, 5586.357568879631, 5596.18855265976, 5603.915941260966, 5621.662700237999, 5543.695096769717, 5572.916406253828, 5584.804531841366, 5617.157426385911, 5676.290463692038, 5463.153211252262, 5475.041867673221, 5479.671219726829, 5493.09363954943, 5497.5601951842955, 5371.194320851903, 5444.156155795858, 5448.809291674773, 5457.645253058538, 5465.152901300305, 5410.188471729272, 5425.620206585501, 5455.1544510600925, 5471.23402723627, 5561.499465048165, 5585.469380408855, 5613.831585052455, 5621.606487545832, 5628.437156284339, 5644.209810626434, 5304.681719096712, 5451.809186678447, 5473.343198816167, 5474.863128421821, 5484.588655850747], "value": 5189.947891655084, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.7887421091303, 584.6579750845755, 592.1768741449386, 596.7016491754123, 625.4589779840438, 33157.17107072324, 44260.55739442605, 45505.0, 45635.54364456354, 45660.77169614151, 45024.874378140565, 45408.545914540846, 45515.54484455154, 45518.544814551846, 45519.31721024179, 8036.758897233063, 8872.73381798547, 9034.68378606749, 9071.319651026199, 10627.415492147968, 10500.109980203599, 10979.945100274528, 10984.121270298358, 10992.395418252034, 10992.890071099306, 11056.502457389397, 11083.667489975272, 11089.611863584776, 11104.389258590774, 11120.0, 10982.670519884376, 10996.835047474295, 11021.504032318566, 11032.669019929415, 11048.392338421383, 10695.78608427827, 10766.300190487593, 10769.515371808287, 10772.353658780497, 10775.191860610406, 42820.1435971282, 43196.35205471889, 43219.56780432187, 43230.783846080885, 43263.13473730508, 3548.4854696069183, 3725.068732816796, 3740.869069582579, 3934.9016274593077, 4268.637165840907, 32557.51163732546, 33083.50374744381, 33375.33249335024, 33573.32853342944, 33623.49564756531, 4232.470941132358, 4339.500957389909, 4351.216780979423, 4493.101379724036, 4510.932336014929, 374132.0, 374660.0, 375954.99999999726, 376076.0, 376513.0, 59616.70191649101, 59842.0, 59892.401075989554, 59995.40004599986, 60006.69996649989, 61814.38185618176, 61886.38113618896, 61887.6905615478, 62038.689806550676, 62158.68920655368, 16226.269817857989, 16444.0, 16461.506154815375, 16468.341266349213, 16476.340946362252, 12034.578789742493, 12914.741705166032, 13185.340732963314, 13292.20246785196, 13295.135816171918, 16756.916215418845, 16996.49010529686, 17013.404530841362, 17069.57326066858, 17158.48524544266, 5988.191594134736, 6033.245844269466, 6053.243344581927, 6088.452039316483, 6187.412195841388, 897.8114595934927, 991.3358050106445, 1102.366139469808, 1118.3290025984345, 1165.3241120150292, 32731.836340818143, 32756.672433275362, 33040.50439243413, 33070.338593228, 33285.50071748926, 1099.8240281554913, 1122.7080958950733, 1156.670348950545, 1181.0, 1187.5665382135458, 17026.489205323862, 17307.826921730873, 17325.65348693044, 17387.21757520889, 17389.565260868578, 148307.0, 149581.0, 150438.0, 150470.24764876105, 151416.0, 60091.699541502014, 60294.779365444876, 60320.39679603236, 60326.69836650876, 60496.69751651213, 1227.404708716272, 1349.4602159136227, 1371.7599420101642, 1386.286062677742, 1409.4221369238562, 32678.34643307073, 33507.83246083754, 34046.65953340534, 34181.48727769036, 34439.82780086083, 50266.49733502618, 50483.0, 50987.0, 51012.0, 51070.0, 393294.0, 394909.0, 396745.0, 398327.0, 398996.0, 35698.46452303269, 40623.187536248515, 41267.0, 41437.171256575304, 42029.0, 48258.0, 48395.27407088967, 48811.511884880696, 49323.50676493333, 49727.75136124296, 41120.0, 41157.1768564633, 41176.38235426411, 42085.57914420817, 43621.345679815466, 41699.7915010423, 41987.7900610495, 42115.368269476596, 42140.578594213664, 42983.570164297955, 40704.59295407127, 41658.79170604249, 41777.0, 42009.36985945152, 42029.1594168121, 35022.12444688903, 36110.45834312435, 37274.0, 38368.80815595904, 40908.59091409167, 28043.859780700965, 28269.858650706614, 28441.0, 28640.0, 28847.5672864903], "value": 20205.470214494762, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.4179211755782, 362.9364861149299, 366.69564261662816, 366.72129181821805, 385.974911630744, 14731.926340368296, 19163.0, 20178.991050447476, 20462.590748185026, 21766.673499897475, 16732.916335418337, 20067.59864802703, 20154.589178757455, 20198.091085901135, 20227.696584551242, 5511.862203444906, 5778.768849246025, 5784.82645520635, 5787.508061814729, 5788.247527821399, 5509.531689806371, 5630.5495560355275, 5676.631018983753, 5700.087985922253, 5702.030654788675, 5657.490825825675, 5662.858428539278, 5664.575156863231, 5665.291838520185, 5667.8583035424035, 5527.613067085305, 5624.606277560552, 5642.294713160855, 5649.180868774005, 5684.090545512699, 5019.974900125512, 5021.372328458942, 5022.0, 5027.321311622957, 5030.346055012861, 22396.0, 23142.88428557863, 23785.643215351785, 24283.63574546383, 24564.877175614187, 2235.519363336874, 2252.481929156303, 2333.1134169015836, 2334.661474086248, 2732.303262668027, 10071.395716257048, 10252.89747102527, 10268.435236062014, 10341.534630941625, 11074.667759967213, 1913.0, 1943.4364034429998, 1948.503131701407, 1978.5449346650207, 2000.7999200080021, 61274.0808887867, 66421.66789166072, 78903.60548197222, 88842.0, 94825.0, 10429.895701043044, 10594.735131621772, 10721.624743134109, 10753.193510486744, 10856.294340867818, 15032.0, 15061.623459413602, 15082.321295541507, 15083.190017198007, 15083.773743393858, 7824.804379890548, 7969.242921922408, 7998.440109192417, 8161.387895907831, 8423.831523369498, 7948.721794737156, 7996.0, 8004.359651227888, 8269.710560130367, 8286.668533258602, 4501.437320334958, 4575.039241759201, 4615.515370886076, 4767.809287628456, 4782.736949467812, 1962.1268535501565, 1972.142118178597, 2026.2401599400225, 2026.9695954560693, 2043.1827269092184, 853.7353420439683, 910.299069716328, 922.4050487435567, 926.1386910173469, 985.5023213277249, 19535.120919558653, 20308.390748277576, 20371.79628203699, 20412.795872041388, 20603.0, 915.8946721127155, 949.3971328206638, 968.5109019945023, 986.2011770465946, 997.9351342162736, 11005.779884402267, 11304.491297891615, 11462.083033357312, 11474.196806223485, 11503.712407189887, 381374.0, 390231.0, 486175.0, 495683.0, 496435.0, 63084.36915630877, 76476.0, 90669.0, 91672.0, 101854.49072754588, 996.9750756231152, 1001.3541265883464, 1022.381459217163, 1035.7048241251207, 1040.089921318846, 18101.0, 18118.0, 18403.81596184021, 18970.43088707341, 19383.321583744502, 33756.83121584376, 36355.364008619144, 45885.541144588125, 46241.53758462372, 47590.524094758606, 64475.23010083874, 64822.0, 65234.0, 65804.6709766448, 66586.6670666663, 8177.386695997943, 8213.3429325655, 8289.709860154866, 8400.243978042006, 8548.513010228242, 11870.703232419259, 13290.20258784476, 13346.866531334563, 13521.459141634225, 13921.373538191008, 11484.310941343547, 11759.218830627542, 11794.587189448328, 11945.940270298941, 12334.568290109803, 10794.460276986276, 11572.6528204154, 11628.0, 11640.417979100841, 11807.350595717318, 11331.886681133083, 11681.941590291994, 11785.175037747274, 11792.115591330856, 11879.524819007143, 7493.288137626917, 7781.494202876795, 7937.404694647809, 8224.0, 9029.683961061332, 11395.316281023164, 11670.591529296435, 11709.473073711533, 12046.337451440255, 12057.758844823229], "value": 9156.969441657511, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.2654646130475, 1513.0845838267846, 1609.2114863716781, 1755.7717496725425, 1799.7480352750617, 8631.568421578919, 9320.067993200677, 9324.347295689304, 9328.253739700816, 9331.44011359318, 7976.800579985504, 8378.832423351529, 8575.742727718163, 8637.697680581181, 9198.678046268382, 2370.715514138306, 2404.422938494766, 2405.7594240575977, 2407.0, 2410.927672169829, 2350.74141844397, 2373.6558199061124, 2411.602085655865, 2413.9275821725287, 2415.9732113851633, 2365.881705914706, 2381.559411508868, 2385.7375688674233, 2390.8206884483648, 2390.9043638254448, 2299.6895419118373, 2319.5013072189477, 2332.4518738096617, 2334.5564342774906, 2335.07764433048, 2328.301509547146, 2338.894749736266, 2342.508073304608, 2342.6837376954236, 2346.9295921122393, 8892.199702026785, 8954.686585969459, 8993.685221017298, 9022.368434209608, 9023.909760902372, 5254.658447200958, 5393.514583687487, 5397.649152805055, 5406.270153529263, 5411.161270003156, 3422.709069729076, 3471.7916924984584, 3485.825708714554, 3492.336456073338, 3529.594096678889, 1075.7848430313968, 1087.0, 1093.9617113400993, 1098.5111625326733, 1109.8224284114583, 12703.491860325576, 12750.87249127506, 12763.170393924458, 12764.234145951272, 12790.872091279061, 4424.823007079745, 4641.396618439649, 4787.61699064074, 4807.903841923212, 4815.686980346266, 10604.204684648683, 10604.734881628021, 10627.0, 10639.255252132276, 10639.468026598639, 5413.350397952192, 5428.240046393429, 5430.42980487051, 5438.510534051954, 5439.075357189287, 4377.124575084932, 4800.0, 4872.3909511311085, 4911.140550403737, 5005.0240203160765, 3875.612438756158, 4001.3997900315185, 4073.6537394321813, 4075.49056367954, 4090.5091389033505, 1273.3378643105534, 1274.6367285323638, 1287.5043108403331, 1292.3215311961296, 1304.9217046977212, 988.2489308125732, 999.8700168977987, 1006.0844631385404, 1007.7279134633608, 1012.7417508535276, 5872.794452194153, 6159.414855588712, 6299.464545513682, 6305.653189074553, 6384.4254017137755, 416.8603517821564, 431.2840684463775, 437.08212753217987, 441.05834044315617, 443.560874734011, 3728.5898551159353, 3741.607131251234, 3769.3026790043928, 3782.3569993101237, 3791.374423220193, 10991.955764202388, 11375.26060806045, 11448.370339631234, 11505.252158609663, 11556.075513958864, 10814.459277036116, 11260.662180134608, 11510.712232194262, 11515.481803318871, 11521.07831373488, 8397.664093436317, 8567.914320856837, 8581.399302048796, 8601.225889669835, 8601.35489838252, 6121.663308517896, 6168.352323006199, 6171.228596425447, 6244.2819075806865, 6409.03864420322, 10597.25819192649, 10630.30902991334, 10644.0, 10662.626808061681, 10755.67732967981, 10233.283670143019, 10615.734606634896, 10706.732331691459, 10707.357558546511, 11003.064739496913, 7342.632868356668, 7850.607469626381, 7861.213878612093, 7986.920130798618, 8008.399370047387, 8850.601722922613, 8985.281177505914, 8991.82016359656, 9009.81980360376, 9024.503652299187, 7889.487183333065, 7896.32881205104, 7929.326007289445, 8121.187881211831, 8181.754547363588, 7789.454738168274, 7828.882566761617, 7913.841723165619, 7990.960045199737, 8002.159773223728, 7390.337174135777, 7417.295356941082, 7504.0, 7504.474686772092, 7519.473636845369, 5321.521063104339, 5487.670739755467, 5500.257465242141, 5514.448555144453, 5645.4072322405555, 5289.414678724858, 5394.352677678704, 5462.071447853795, 5476.808311709071, 5531.834044978657], "value": 4661.975763145409, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.4102205808964, 312.8138757439323, 314.4763967993291, 321.44550650128525, 333.52472726364937, 5312.893742125155, 5351.25082488452, 5355.4912283333115, 5372.489613486718, 5397.784088636459, 5263.447338029509, 5269.0, 5310.548603368718, 5314.282571852798, 5320.095583750762, 3939.2909276330247, 3983.2033593281317, 4115.670746340285, 4174.582541745832, 4195.538490766014, 4155.189738001076, 4157.438745769327, 4165.83336666533, 4170.77060761658, 4192.517860446042, 4113.897152571195, 4117.5882411758885, 4126.977780887359, 4133.731307465006, 4149.668026557868, 3960.3465428204454, 3987.4616926714957, 4112.300908845504, 4126.195391898581, 4150.107726838714, 3664.1862278172475, 3666.816659167058, 3668.816559172031, 3669.7614655047605, 3674.375356189454, 5114.207297868837, 5125.282460455539, 5147.845564633029, 5148.588112950955, 5171.818986335498, 4418.513963464048, 4663.137319595886, 4675.906481870377, 4700.0, 4740.597049250818, 5458.727063646802, 5481.561475081984, 5487.228949380577, 5494.835154945358, 5505.284313039279, 3923.195744872294, 3927.5483319418345, 3932.2528719543197, 3938.72428929975, 3963.8810835674976, 5555.777768889239, 5676.6659834938755, 5683.573731970118, 5688.857778555528, 5765.0, 3990.880273591739, 4008.6971734186504, 4012.0371110933747, 4041.959580404217, 4057.411675307064, 4071.6742660587083, 4092.529359123679, 4097.75018619324, 4105.609967053125, 4109.753414795062, 4570.565796249351, 4590.6228131561065, 4660.3688708951595, 4663.230566956482, 4665.883352916137, 5483.1227003680015, 5486.177073439016, 5493.560515158778, 5518.558515318845, 5548.69482178476, 1369.5275130080106, 1383.481194552043, 1387.1330418488444, 1388.3544151969384, 1391.1444461656008, 845.754731127966, 866.3415803988888, 905.0, 919.6091661044029, 925.1534845616186, 5143.562797162208, 5321.574274058144, 5333.813316533902, 5355.7054362009685, 5359.839204823784, 5655.236543066633, 5673.553243922774, 5685.891251205975, 5686.829395118153, 5709.800156994485, 5094.0, 5337.412884582693, 5392.433794451605, 5394.352677678704, 5415.48552887475, 2955.349823038928, 3012.584085479821, 3023.8488075596133, 3024.1834704629628, 3024.682408347092, 5921.496672782776, 5935.52515798735, 5937.6734279614175, 5943.58394912352, 5947.345791962881, 5581.302337207849, 5725.341585717612, 5734.455226753452, 5740.564858785304, 5759.971200143972, 5841.714822738991, 5867.794627188114, 5883.675723216369, 5886.352501224862, 5934.6142500737315, 5410.891782164414, 5638.984982702988, 5665.773369065356, 5668.603197776116, 5702.543796496353, 5572.693501857275, 5620.297462817148, 5634.267545219095, 5677.914831277617, 5698.091139468324, 5794.783095549813, 5863.2670916135485, 5891.823245302648, 5927.199828023162, 5932.970335148297, 3920.6471417572557, 4020.698447616382, 4031.6976226783695, 4082.4692789937117, 4092.386142078593, 5661.490465858093, 5701.287339082614, 5705.144228365778, 5710.915515836773, 5764.221830052889, 5527.613067085426, 5670.234518339971, 5685.0, 5685.943140568541, 5690.857728556819, 5566.443355664401, 5574.554035677217, 5575.1915972183, 5584.078627026495, 5593.804216852391, 5475.835724928259, 5489.258950041853, 5489.3687225969525, 5520.475554822286, 5534.667919924817, 5386.703731294817, 5390.730463476732, 5553.777848885999, 5565.66424058215, 5572.219889215432, 5469.0740453857, 5493.395726470165, 5499.230107784993, 5502.58730595199, 5512.877542146222], "value": 4215.173696480851, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.3227678950549, 770.3375097416225, 798.3373799746212, 804.9235322644347, 846.1496196322695, 15331.770023449642, 16626.83373166268, 16678.249478773454, 16689.91655041726, 16704.665906681857, 15512.922435387836, 15720.37118515261, 15722.135282559455, 15730.977486463373, 15746.133962632051, 652.6540933305356, 774.0865778381508, 785.8585454618167, 806.4999700185864, 814.6578437056421, 814.5723495165056, 817.5707753429438, 819.4345901328064, 821.7165078048064, 822.5188264865061, 867.7266661001796, 869.1308691308691, 869.7869022089596, 870.0777176193255, 870.1168314161132, 700.2402393403164, 863.3481721300441, 863.848826455371, 864.3344624638993, 864.576357584782, 612.13077430049, 631.7757196195377, 638.7540796793268, 638.7796210307437, 638.9488840892717, 14057.367418466194, 14099.36552855124, 14102.083364581373, 14105.294735263298, 14139.222342771143, 13637.931810340884, 14309.642258943506, 14562.199079050648, 14656.633584160374, 14730.852691473163, 13539.661508462368, 13599.04700451682, 13688.794668079987, 13699.45202191911, 14068.859311406857, 4449.859827434193, 4513.187626227278, 4514.906770365932, 4518.615917647004, 4527.230370836965, 85765.57117214374, 85865.0, 87864.0, 88784.11215887759, 90487.0, 10255.58977640886, 10718.785624287471, 11606.88393116058, 11863.88136118645, 11906.345151016603, 23275.650865237036, 23322.0, 23398.415039623804, 23444.0, 23444.296671099895, 8659.220670139717, 8778.122187781171, 8812.471251724917, 8874.29005679544, 9055.59249833759, 4672.724457121763, 4746.121967436035, 4766.142094423037, 4820.807167713322, 4979.029089327619, 3609.819509024538, 3710.128119891823, 3715.4241092630687, 3717.9628203718157, 3728.5339332583426, 609.2297312046665, 620.5912578446901, 621.7109044294425, 630.3003665930813, 644.7839973608893, 675.9831004224835, 686.7424715731601, 713.9500234983501, 714.3820595185127, 724.9891251631229, 8712.607932643046, 9088.272938164931, 9276.953615231881, 9310.767230819283, 9392.938936973871, 681.3867519232631, 683.6103421049954, 698.2458944340101, 707.306839297481, 707.5118168463744, 4407.537208593116, 4549.6360291176625, 4603.95396046042, 4626.6007100969055, 4647.279671650899, 74379.0, 76427.61786191145, 101282.49358753307, 123540.0, 130276.3486182563, 69287.3071269291, 108832.4558377203, 114323.0, 115355.0, 116743.0, 72357.0, 98384.0, 98867.0, 102208.48895755623, 103729.48135259426, 8472.788180295542, 8512.489250644981, 8560.91439085626, 8663.306935445275, 9027.187553120251, 58818.41181588129, 59561.40438595558, 60122.36899187774, 60528.0, 62124.0, 83416.58291708502, 85769.14230857612, 86823.0, 87710.56144719491, 90577.54711226402, 11797.587084452003, 11884.82172767392, 12080.51677932908, 12172.452239649414, 12219.900208981235, 12192.0, 12451.252924824177, 12748.61754147377, 12764.489420423079, 12911.0, 12088.39558022113, 12097.818532722193, 12232.87767122353, 12545.31000794965, 12919.817104956019, 10960.616378426717, 11055.447227638426, 11189.72025699364, 11518.539258429904, 11579.652610421701, 11543.36511491876, 11861.110416718953, 11879.58421455245, 11980.28118312904, 12164.39178041112, 9752.0, 10040.447775372424, 10063.29556931037, 10291.073803357735, 10463.68608941733, 9439.905600943903, 9819.754506137404, 9845.113939745457, 9856.112949834549, 9905.55425005862], "value": 7542.8713886129435, "unit": "score"}], "name": "dromaeo_css", "value": 7225.8999186249475, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 112.0, 110.0, 114.0, 111.0, 111.0, 112.0, 111.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 116.0, 121.0, 187.0, 119.0, 123.0, 140.0, 117.0, 155.0, 117.0], "value": 133.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 161.0, 160.0, 159.0, 161.0, 161.0, 160.0, 159.0, 161.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 74.0, 107.0, 74.0, 75.0, 75.0, 75.0, 99.0, 74.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 126.0, 84.0, 85.0, 84.0, 123.0, 83.0, 84.0, 129.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 118.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 50.0, 51.0, 49.0, 50.0, 49.0, 50.0, 51.0, 50.0], "value": 50.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 81.0, 74.0, 76.0, 81.0, 75.0, 75.0, 75.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 131.0, 122.0, 120.0, 122.0, 129.0, 119.0, 132.0, 132.0, 123.0], "value": 126.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 162.0, 165.0, 158.0, 159.0, 162.0, 158.0, 158.0, 161.0, 158.0], "value": 159.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 63.0, 63.0, 64.0, 64.0, 62.0, 63.0, 62.0, 68.0], "value": 63.9, "unit": "score"}], "name": "kraken", "value": 1477.9, "alertThreshold": 2.0}]} 08:25:28 INFO - Return code: 0 08:25:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:25:28 INFO - # TBPL SUCCESS # 08:25:28 INFO - Running post-action listener: _resource_record_post_action 08:25:28 INFO - [mozharness: 2016-08-05 15:25:28.978677Z] Finished run-tests step (success) 08:25:28 INFO - Running post-run listener: _resource_record_post_run 08:25:29 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 12288; Write bytes: 424882176; Read time: 28; Write time: 307636 08:25:29 INFO - TinderboxPrint: CPU usage
13.0% 08:25:29 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 28 08:25:29 INFO - TinderboxPrint: I/O write bytes / time
424,882,176 / 307,636 08:25:29 INFO - TinderboxPrint: CPU idle
8,284.3 (87.0%) 08:25:29 INFO - TinderboxPrint: CPU user
1,193.3 (12.5%) 08:25:29 INFO - TinderboxPrint: Swap in / out
0 / 0 08:25:29 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 134762496; Read time: 0; Write time: 105152 08:25:29 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 289701888; Read time: 16; Write time: 202408 08:25:29 INFO - Running post-run listener: _upload_blobber_files 08:25:29 INFO - Blob upload gear active. 08:25:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:25:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:25:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:25:30 INFO - (blobuploader) - INFO - Open directory for files ... 08:25:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:25:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:25:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:31 INFO - (blobuploader) - INFO - Done attempting. 08:25:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:25:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:25:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:31 INFO - (blobuploader) - INFO - Done attempting. 08:25:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:25:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:25:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:35 INFO - (blobuploader) - INFO - Done attempting. 08:25:35 INFO - (blobuploader) - INFO - Iteration through files over. 08:25:35 INFO - Return code: 0 08:25:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:25:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:25:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fd74d514a24a2c2d87f2b043da98f41c1fb80b76b871748a2afe25110545ab9648ef56645316cb88b45f68c9b47f24489365a7b7ce37d9e879915f17ed9d330e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/47c39b290ca55c229ade8be7b4ab4a8fc3a7864e6e09c11279b469f04d8ff6e5b2d894a98f1674c547da0444a3296ec190e10d4c40792e1190686dc24ca9e169", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/269c6febc9941a58895bebadb61727db3f86df1743f192fd6a748afc249b483848e084be828ffffaf1fda384cdce368742ab35435007bccb647b2d31584b0e85"} 08:25:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:25:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:25:35 INFO - Contents: 08:25:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fd74d514a24a2c2d87f2b043da98f41c1fb80b76b871748a2afe25110545ab9648ef56645316cb88b45f68c9b47f24489365a7b7ce37d9e879915f17ed9d330e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/47c39b290ca55c229ade8be7b4ab4a8fc3a7864e6e09c11279b469f04d8ff6e5b2d894a98f1674c547da0444a3296ec190e10d4c40792e1190686dc24ca9e169", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/269c6febc9941a58895bebadb61727db3f86df1743f192fd6a748afc249b483848e084be828ffffaf1fda384cdce368742ab35435007bccb647b2d31584b0e85"} 08:25:35 INFO - Running post-run listener: copy_logs_to_upload_dir 08:25:35 INFO - Copying logs to upload dir... 08:25:35 INFO - mkdir: /builds/slave/test/build/upload/logs 08:25:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.854474 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-05 08:25:35.512568) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 08:25:35.515810) ========= 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=6d15e502d8e29d5d2676d664000001c3-1470409325.720656-1414100035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fd74d514a24a2c2d87f2b043da98f41c1fb80b76b871748a2afe25110545ab9648ef56645316cb88b45f68c9b47f24489365a7b7ce37d9e879915f17ed9d330e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/47c39b290ca55c229ade8be7b4ab4a8fc3a7864e6e09c11279b469f04d8ff6e5b2d894a98f1674c547da0444a3296ec190e10d4c40792e1190686dc24ca9e169", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/269c6febc9941a58895bebadb61727db3f86df1743f192fd6a748afc249b483848e084be828ffffaf1fda384cdce368742ab35435007bccb647b2d31584b0e85"} build_url:https://queue.taskcluster.net/v1/task/M6tcCWwlTUWE7KtfM6gt9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011123 build_url: 'https://queue.taskcluster.net/v1/task/M6tcCWwlTUWE7KtfM6gt9Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fd74d514a24a2c2d87f2b043da98f41c1fb80b76b871748a2afe25110545ab9648ef56645316cb88b45f68c9b47f24489365a7b7ce37d9e879915f17ed9d330e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/47c39b290ca55c229ade8be7b4ab4a8fc3a7864e6e09c11279b469f04d8ff6e5b2d894a98f1674c547da0444a3296ec190e10d4c40792e1190686dc24ca9e169", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/269c6febc9941a58895bebadb61727db3f86df1743f192fd6a748afc249b483848e084be828ffffaf1fda384cdce368742ab35435007bccb647b2d31584b0e85"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 08:25:35.542069) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 08:25:35.542563) ========= 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=6d15e502d8e29d5d2676d664000001c3-1470409325.720656-1414100035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 08:25:35.627759) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 08:25:35.628278) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 08:25:35.628735) ========= ========= Total master_lag: 0.18 =========