| Summary: | Zone changed causes traceback and test stop working | ||||||
|---|---|---|---|---|---|---|---|
| Product: | [Fedora] Fedora | Reporter: | Petr Sklenar <psklenar> | ||||
| Component: | beakerlib | Assignee: | Petr Muller <pmuller> | ||||
| Status: | CLOSED CURRENTRELEASE | QA Contact: | |||||
| Severity: | high | Docs Contact: | |||||
| Priority: | high | ||||||
| Version: | 19 | CC: | amarecek, jhutar, jmikulka, kvolny, ohudlick, pmuller, psplicha, qa-errata-list | ||||
| Target Milestone: | --- | Keywords: | Regression, TestBlocker | ||||
| Target Release: | --- | ||||||
| Hardware: | Unspecified | ||||||
| OS: | Unspecified | ||||||
| Whiteboard: | |||||||
| Fixed In Version: | Doc Type: | Bug Fix | |||||
| Doc Text: | Story Points: | --- | |||||
| Clone Of: | |||||||
| : | 893060 (view as bug list) | Environment: | |||||
| Last Closed: | 2013-06-27 16:36:10 UTC | Type: | --- | ||||
| Regression: | --- | Mount Type: | --- | ||||
| Documentation: | --- | CRM: | |||||
| Verified Versions: | Category: | --- | |||||
| oVirt Team: | --- | RHEL 7.3 requirements from Atomic Host: | |||||
| Cloudforms Team: | --- | Target Upstream Version: | |||||
| Bug Depends On: | |||||||
| Bug Blocks: | 893060 | ||||||
| Attachments: |
|
||||||
*** Bug 695047 has been marked as a duplicate of this bug. *** Ugh, this area of python 'time' module is apparently a mine field. I *think* this is actually a Python bug, because u'2011-04-05 04:24:54 EDT' *does* match format '%Y-%m-%d %H:%M:%S %Z'. But the support for %Z is a gray area according to docs. And I found some bugs in Python tracking tool dancing around this. Not sure how to fix this. What is the expected result in this case anyways? I guess the ideal would be if beakerlib could just figure out the real duration, but that is quite hard with timezones getting mixed under it's hands. Considering this is quite special case, would it be acceptable to give up computing duration in this case and say it is unknown because time was messed up somehow? I guess the real pain is the WARN you are getting now. (In reply to comment #2) > I guess the real pain is the WARN you are getting now. exactly, I don't care time duration but only these warn ... *** Bug 709687 has been marked as a duplicate of this bug. *** Created attachment 502275 [details]
the reproducer
(In reply to comment #2) > Considering this is quite special case, would it be acceptable to give up > computing duration in this case and say it is unknown because time was messed > up somehow? I guess the real pain is the WARN you are getting now. +1 for giving up computing the duration and keeping the correct test phase status. I've just experienced this bug too: http://beaker-archive.app.eng.bos.redhat.com/beaker-logs/2011/10/1435/143598/298867/3294206/TESTOUT.log Traceback (most recent call last): File "/usr/bin/beakerlib-journalling", line 468, in <module> createLog(options.testid, options.severity) File "/usr/bin/beakerlib-journalling", line 181, in createLog printPhaseLog(nod,severity) File "/usr/bin/beakerlib-journalling", line 94, in printPhaseLog duration = time.mktime(time.strptime(endtime,timeFormat)) - time.mktime(time.strptime(starttime,timeFormat)) File "/usr/lib/python2.6/_strptime.py", line 454, in _strptime_time return _strptime(data_string, format)[0] File "/usr/lib/python2.6/_strptime.py", line 325, in _strptime (data_string, format)) ValueError: time data u'2011-10-15 00:02:06 EDT' does not match format '%Y-%m-%d %H:%M:%S %Z' '442120f2-73b8-4b04-b0f6-19fdc1ab5347' note that there are some avc messages which may be relevant: http://beaker-archive.app.eng.bos.redhat.com/beaker-logs/2011/10/1435/143598/298867/3294206/17558086/test_log-Setup-avc.log time->Sat Oct 15 04:02:02 2011 type=AVC msg=audit(1318651322.613:177735): avc: denied { recv } for saddr=10.16.64.14 src=67 daddr=255.255.255.255 dest=68 netif=eth0 scontext=system_u:system_r:dhcpc_t:s0 tcontext=system_u:object_r:unlabeled_t:s0 tclass=packet ---- time->Sat Oct 15 04:02:06 2011 type=AVC msg=audit(1318651326.586:177736): avc: denied { recv } for pid=17417 comm="python" saddr=10.16.64.14 src=67 daddr=255.255.255.255 dest=68 netif=eth0 scontext=system_u:system_r:dhcpc_t:s0 tcontext=system_u:object_r:unlabeled_t:s0 tclass=packet my test is still crying and crying on RHEL7 http://beaker-archive.app.eng.bos.redhat.com/beaker-logs/2012/05/2399/239901/510773/6017922/TESTOUT.log what's the status of this bug? (In reply to comment #8) > what's the status of this bug? No progress, obviously. I'll try to look into it next week. http://git.fedorahosted.org/git?p=beakerlib.git;a=commit;h=2d0d441cf947cf2959142d57c760f221e911a6aa This should help. beakerlib-1.6-1 is already in fedora This bug appears to have been reported against 'rawhide' during the Fedora 19 development cycle. Changing version to '19'. (As we did not run this process for some time, it could affect also pre-Fedora 19 development cycle bugs. We are very sorry. It will help us with cleanup during Fedora 19 End Of Life. Thank you.) More information and reason for this action is here: https://fedoraproject.org/wiki/BugZappers/HouseKeeping/Fedora19 |
Description of problem: Zone changed causes traceback and test stop working Version-Release number of selected component (if applicable): beakerlib-redhat-1-4.el6.noarch How reproducible: always Steps to Reproduce: 1. cat runtest.sh . /usr/bin/rhts-environment.sh . /usr/share/rhts-library/rhtslib.sh PACKAGE=coreutils rlJournalStart rlPhaseStartSetup "playing with setting" rlRun "cp -f /usr/share/zoneinfo/Europe/London /etc/localtime" rlRun 'echo ZONE="Europe/London" > /etc/sysconfig/clock' rlRun "date" 0 "`date`" rlPhaseEnd rlJournalPrintText 2. make run causes: :: [ WARNING ] :: POSIX mode detected and switched off :: [ WARNING ] :: Please fix your test to have /bin/bash shebang Traceback (most recent call last): File "/usr/bin/beakerlib-journalling", line 468, in <module> createLog(options.testid, options.severity) File "/usr/bin/beakerlib-journalling", line 181, in createLog printPhaseLog(nod,severity) File "/usr/bin/beakerlib-journalling", line 94, in printPhaseLog duration = time.mktime(time.strptime(endtime,timeFormat)) - time.mktime(time.strptime(starttime,timeFormat)) File "/usr/lib64/python2.6/_strptime.py", line 454, in _strptime_time return _strptime(data_string, format)[0] File "/usr/lib64/python2.6/_strptime.py", line 325, in _strptime (data_string, format)) ValueError: time data u'2011-04-05 04:24:54 EDT' does not match format '%Y-%m-%d %H:%M:%S %Z' make: *** [run] Error 1 Actual results: traceback, and test fail Expected results: no traceback Additional info: http://beaker-archive.app.eng.bos.redhat.com/beaker-logs/2011/04/692/69293/142237/1554580///TESTOUT.log