[tahoe-lafs-trac-stream] [tahoe-lafs] #1467: nondeterministic test failure in allmydata.test.test_system.SystemTest.test_filesystem because the Welcome page says "Connected to helper: no" when the test expected "yes"

tahoe-lafs trac at tahoe-lafs.org
Wed Feb 8 18:26:13 UTC 2012


#1467: nondeterministic test failure in
allmydata.test.test_system.SystemTest.test_filesystem because the Welcome
page says "Connected to helper: no" when the test expected "yes"
----------------------------+----------------------------
     Reporter:  davidsarah  |      Owner:  somebody
         Type:  defect      |     Status:  new
     Priority:  major       |  Milestone:  undecided
    Component:  code        |    Version:  1.8.2
   Resolution:              |   Keywords:  test heisenbug
Launchpad Bug:              |
----------------------------+----------------------------

Comment (by zooko):

 {{{test_filesystem}}} just irreproducible {{{FAIL}}}ed again, and this
 time it happened on one my favorite buildslaves -- the eminently stable
 and well-performing "Kyle OpenBSD amd64":

 https://tahoe-lafs.org/buildbot-tahoe-
 lafs/builders/Kyle%20OpenBSD%20amd64/builds/22

 This time there was a different error message, which might be a useful
 clue:

 {{{
 twisted.web.error.Error: 404 Not Found
 }}}

 Here is the part of the {{{test.log}}} which appears after it announces
 {{{SystemTest.test_filesystem}}} and before it announces the next test
 ({{{SystemTest.test_filesystem_with_cli_in_subprocess}}}):

 {{{
 2012-02-01 01:36:53.422Z [-] -->
 allmydata.test.test_system.SystemTest.test_filesystem <--
 2012-02-01 01:36:53.434Z [-] foolscap.pb.Listener starting on 19624
 2012-02-01 01:36:53.435Z [-] nevow.appserver.NevowSite starting on 19673
 2012-02-01 01:36:53.435Z [-] Starting factory <nevow.appserver.NevowSite
 instance at 0x21d8becf8>
 2012-02-01 01:36:53.436Z [-] My pid: 30725
 2012-02-01 01:36:53.438Z [-] twisted.internet.protocol.DatagramProtocol
 starting on 2948
 2012-02-01 01:36:53.439Z [-] Starting protocol
 <twisted.internet.protocol.DatagramProtocol instance at 0x202adedd0>
 2012-02-01 01:36:53.450Z [-] (Port 2948 Closed)
 2012-02-01 01:36:53.452Z [-] Stopping protocol
 <twisted.internet.protocol.DatagramProtocol instance at 0x202adedd0>
 2012-02-01 01:36:53.614Z [-] foolscap.pb.Listener starting on 35768
 2012-02-01 01:36:54.296Z [-] twisted.internet.protocol.DatagramProtocol
 starting on 34635
 2012-02-01 01:36:54.297Z [-] Starting protocol
 <twisted.internet.protocol.DatagramProtocol instance at 0x202adedd0>
 2012-02-01 01:36:54.361Z [-] foolscap.pb.Listener starting on 37699
 2012-02-01 01:36:54.362Z [-] nevow.appserver.NevowSite starting on 46227
 2012-02-01 01:36:54.362Z [-] Starting factory <nevow.appserver.NevowSite
 instance at 0x21d2cc488>
 2012-02-01 01:36:54.363Z [-] My pid: 30725
 2012-02-01 01:36:54.363Z [-] (Port 34635 Closed)
 2012-02-01 01:36:54.364Z [-] Stopping protocol
 <twisted.internet.protocol.DatagramProtocol instance at 0x202adedd0>
 2012-02-01 01:36:54.365Z [-] twisted.internet.protocol.DatagramProtocol
 starting on 19862
 2012-02-01 01:36:54.365Z [-] Starting protocol
 <twisted.internet.protocol.DatagramProtocol instance at 0x21d937f80>
 2012-02-01 01:36:54.366Z [-] (Port 19862 Closed)
 2012-02-01 01:36:54.366Z [-] Stopping protocol
 <twisted.internet.protocol.DatagramProtocol instance at 0x21d937f80>
 2012-02-01 01:36:54.439Z [-] foolscap.pb.Listener starting on 7790
 2012-02-01 01:36:54.440Z [-] My pid: 30725
 2012-02-01 01:36:54.487Z [-] foolscap.pb.Listener starting on 35570
 2012-02-01 01:36:54.488Z [-] My pid: 30725
 2012-02-01 01:36:54.537Z [-] foolscap.pb.Listener starting on 7049
 2012-02-01 01:36:54.537Z [-] nevow.appserver.NevowSite starting on 21595
 2012-02-01 01:36:54.538Z [-] Starting factory <nevow.appserver.NevowSite
 instance at 0x2085d2ef0>
 2012-02-01 01:36:54.538Z [-] My pid: 30725
 2012-02-01 01:36:54.586Z [-] foolscap.pb.Listener starting on 24152
 2012-02-01 01:36:54.587Z [-] My pid: 30725
 2012-02-01 01:36:54.589Z [-] twisted.internet.protocol.DatagramProtocol
 starting on 37407
 2012-02-01 01:36:54.590Z [-] Starting protocol
 <twisted.internet.protocol.DatagramProtocol instance at 0x20e547b90>
 2012-02-01 01:36:54.591Z [-] twisted.internet.protocol.DatagramProtocol
 starting on 30005
 2012-02-01 01:36:54.592Z [-] Starting protocol
 <twisted.internet.protocol.DatagramProtocol instance at 0x21dc17680>
 2012-02-01 01:36:54.639Z [-] twisted.internet.protocol.DatagramProtocol
 starting on 6706
 2012-02-01 01:36:54.639Z [-] Starting protocol
 <twisted.internet.protocol.DatagramProtocol instance at 0x21e3a4098>
 2012-02-01 01:36:54.662Z [-] twisted.internet.protocol.DatagramProtocol
 starting on 30125
 2012-02-01 01:36:54.663Z [-] Starting protocol
 <twisted.internet.protocol.DatagramProtocol instance at 0x21dc2bc68>
 2012-02-01 01:36:54.668Z [-] (Port 37407 Closed)
 2012-02-01 01:36:54.669Z [-] Stopping protocol
 <twisted.internet.protocol.DatagramProtocol instance at 0x20e547b90>
 2012-02-01 01:36:54.670Z [-] (Port 30005 Closed)
 2012-02-01 01:36:54.670Z [-] Stopping protocol
 <twisted.internet.protocol.DatagramProtocol instance at 0x21dc17680>
 2012-02-01 01:36:54.672Z [-] (Port 6706 Closed)
 2012-02-01 01:36:54.672Z [-] Stopping protocol
 <twisted.internet.protocol.DatagramProtocol instance at 0x21e3a4098>
 2012-02-01 01:36:54.673Z [-] (Port 30125 Closed)
 2012-02-01 01:36:54.673Z [-] Stopping protocol
 <twisted.internet.protocol.DatagramProtocol instance at 0x21dc2bc68>
 2012-02-01 01:36:55.806Z [-] Starting factory <HTTPClientFactory:
 http://127.0.0.1:19673/>
 2012-02-01 01:36:55.877Z [HTTPPageGetter,client] Starting factory
 <HTTPClientFactory: http://127.0.0.1:19673/?t=json>
 2012-02-01 01:36:55.877Z [HTTPPageGetter,client] Stopping factory
 <HTTPClientFactory: http://127.0.0.1:19673/>
 2012-02-01 01:36:55.908Z [HTTPPageGetter,client] Stopping factory
 <HTTPClientFactory: http://127.0.0.1:19673/?t=json>
 2012-02-01 01:36:57.423Z [-] (Port 46227 Closed)
 2012-02-01 01:36:57.423Z [-] Stopping factory <nevow.appserver.NevowSite
 instance at 0x21d2cc488>
 2012-02-01 01:36:57.424Z [-] (Port 37699 Closed)
 2012-02-01 01:36:58.484Z [-] foolscap.pb.Listener starting on 37699
 2012-02-01 01:36:58.485Z [-] nevow.appserver.NevowSite starting on 6309
 2012-02-01 01:36:58.485Z [-] Starting factory <nevow.appserver.NevowSite
 instance at 0x21d930ea8>
 2012-02-01 01:36:58.486Z [-] My pid: 30725
 2012-02-01 01:36:58.489Z [-] twisted.internet.protocol.DatagramProtocol
 starting on 34314
 2012-02-01 01:36:58.490Z [-] Starting protocol
 <twisted.internet.protocol.DatagramProtocol instance at 0x21d910b90>
 2012-02-01 01:36:58.494Z [-] (Port 34314 Closed)
 2012-02-01 01:36:58.494Z [-] Stopping protocol
 <twisted.internet.protocol.DatagramProtocol instance at 0x21d910b90>
 2012-02-01 01:37:05.172Z [-] Starting factory <HTTPClientFactory:
 http://127.0.0.1:6309/>
 2012-02-01 01:37:05.211Z [HTTPPageGetter,client] Starting factory
 <HTTPClientFactory: http://127.0.0.1:21595/>
 2012-02-01 01:37:05.212Z [HTTPPageGetter,client] Stopping factory
 <HTTPClientFactory: http://127.0.0.1:6309/>
 2012-02-01 01:37:05.227Z [HTTPPageGetter,client] Starting factory
 <HTTPClientFactory:
 http://127.0.0.1:6309/uri/URI:DIR2:yodtx22564zgatzzowv765umse:gnlv5ryhwfjvzgqcedx5hlihwrbugh6bd5uiu3vupnsvhqqvq2qa>
 2012-02-01 01:37:05.228Z [HTTPPageGetter,client] Stopping factory
 <HTTPClientFactory: http://127.0.0.1:21595/>
 2012-02-01 01:37:05.421Z [HTTPPageGetter,client] Starting factory
 <HTTPClientFactory:
 http://127.0.0.1:6309/uri/URI:DIR2:yodtx22564zgatzzowv765umse:gnlv5ryhwfjvzgqcedx5hlihwrbugh6bd5uiu3vupnsvhqqvq2qa/subdir1>
 2012-02-01 01:37:05.422Z [HTTPPageGetter,client] Stopping factory
 <HTTPClientFactory:
 http://127.0.0.1:6309/uri/URI%3ADIR2%3Ayodtx22564zgatzzowv765umse%3Agnlv5ryhwfjvzgqcedx5hlihwrbugh6bd5uiu3vupnsvhqqvq2qa/>
 2012-02-01 01:37:05.766Z [HTTPPageGetter,client] Starting factory
 <HTTPClientFactory:
 http://127.0.0.1:6309/uri/URI:DIR2:yodtx22564zgatzzowv765umse:gnlv5ryhwfjvzgqcedx5hlihwrbugh6bd5uiu3vupnsvhqqvq2qa/subdir1/mydata567>
 2012-02-01 01:37:05.767Z [HTTPPageGetter,client] Stopping factory
 <HTTPClientFactory:
 http://127.0.0.1:6309/uri/URI%3ADIR2%3Ayodtx22564zgatzzowv765umse%3Agnlv5ryhwfjvzgqcedx5hlihwrbugh6bd5uiu3vupnsvhqqvq2qa/subdir1/>
 2012-02-01 01:37:05.971Z [HTTPPageGetter,client] Starting factory
 <HTTPClientFactory:
 http://127.0.0.1:6309/uri/URI:CHK:gmdbvycnymujkjlj646vkngaw4:zyx5xzvredovnxvio2w6iavlikt7i4ie5yh7okbavsf6zo7c6d5q:3:10:112?filename=mydata567>
 2012-02-01 01:37:05.972Z [HTTPPageGetter,client] Stopping factory
 <HTTPClientFactory:
 http://127.0.0.1:6309/uri/URI:DIR2:yodtx22564zgatzzowv765umse:gnlv5ryhwfjvzgqcedx5hlihwrbugh6bd5uiu3vupnsvhqqvq2qa/subdir1/mydata567>
 2012-02-01 01:37:06.006Z [HTTPPageGetter,client] Starting factory
 <HTTPClientFactory:
 http://127.0.0.1:6309/uri?uri=URI:CHK:gmdbvycnymujkjlj646vkngaw4:zyx5xzvredovnxvio2w6iavlikt7i4ie5yh7okbavsf6zo7c6d5q:3:10:112>
 2012-02-01 01:37:06.007Z [HTTPPageGetter,client] Stopping factory
 <HTTPClientFactory:
 http://127.0.0.1:6309/uri/URI:CHK:gmdbvycnymujkjlj646vkngaw4:zyx5xzvredovnxvio2w6iavlikt7i4ie5yh7okbavsf6zo7c6d5q:3:10:112?filename=mydata567>
 2012-02-01 01:37:06.060Z [HTTPPageGetter,client] Starting factory
 <HTTPClientFactory:
 http://127.0.0.1:6309/uri/URI:CHK:gmdbvycnymujkjlj646vkngawy:zyx5xzvredovnxvio2w6iavlikt7i4ie5yh7okbavsf6zo7c6d5q:3:10:112?filename=mydata567>
 2012-02-01 01:37:06.061Z [HTTPPageGetter,client] Stopping factory
 <HTTPClientFactory:
 http://127.0.0.1:6309/uri/URI%3ACHK%3Agmdbvycnymujkjlj646vkngaw4%3Azyx5xzvredovnxvio2w6iavlikt7i4ie5yh7okbavsf6zo7c6d5q%3A3%3A10%3A112>
 2012-02-01 01:37:06.076Z [HTTPPageGetter,client] Starting factory
 <HTTPClientFactory:
 http://127.0.0.1:6309/uri/URI:DIR2:yodtx22564zgatzzowv765umse:gnlv5ryhwfjvzgqcedx5hlihwrbugh6bd5uiu3vupnsvhqqvq2qa/subdir3/new.txt>
 2012-02-01 01:37:06.077Z [HTTPPageGetter,client] Stopping factory
 <HTTPClientFactory:
 http://127.0.0.1:6309/uri/URI:CHK:gmdbvycnymujkjlj646vkngawy:zyx5xzvredovnxvio2w6iavlikt7i4ie5yh7okbavsf6zo7c6d5q:3:10:112?filename=mydata567>
 2012-02-01 01:37:06.567Z [HTTPPageGetter,client] Starting factory
 <HTTPClientFactory:
 http://127.0.0.1:6309/uri/URI:DIR2:yodtx22564zgatzzowv765umse:gnlv5ryhwfjvzgqcedx5hlihwrbugh6bd5uiu3vupnsvhqqvq2qa/subdir3/new.txt>
 2012-02-01 01:37:06.567Z [HTTPPageGetter,client] Stopping factory
 <HTTPClientFactory:
 http://127.0.0.1:6309/uri/URI:DIR2:yodtx22564zgatzzowv765umse:gnlv5ryhwfjvzgqcedx5hlihwrbugh6bd5uiu3vupnsvhqqvq2qa/subdir3/new.txt>
 2012-02-01 01:37:06.703Z [HTTPPageGetter,client] Starting factory
 <HTTPClientFactory:
 http://127.0.0.1:6309/uri/URI:DIR2:yodtx22564zgatzzowv765umse:gnlv5ryhwfjvzgqcedx5hlihwrbugh6bd5uiu3vupnsvhqqvq2qa/subdir3/big.txt>
 2012-02-01 01:37:06.707Z [HTTPPageGetter,client] Stopping factory
 <HTTPClientFactory:
 http://127.0.0.1:6309/uri/URI:DIR2:yodtx22564zgatzzowv765umse:gnlv5ryhwfjvzgqcedx5hlihwrbugh6bd5uiu3vupnsvhqqvq2qa/subdir3/new.txt>
 2012-02-01 01:37:08.019Z [HTTPPageGetter,client] Starting factory
 <HTTPClientFactory:
 http://127.0.0.1:6309/uri/URI:DIR2:yodtx22564zgatzzowv765umse:gnlv5ryhwfjvzgqcedx5hlihwrbugh6bd5uiu3vupnsvhqqvq2qa/subdir3/big.txt>
 2012-02-01 01:37:08.019Z [HTTPPageGetter,client] Stopping factory
 <HTTPClientFactory:
 http://127.0.0.1:6309/uri/URI:DIR2:yodtx22564zgatzzowv765umse:gnlv5ryhwfjvzgqcedx5hlihwrbugh6bd5uiu3vupnsvhqqvq2qa/subdir3/big.txt>
 2012-02-01 01:37:08.734Z [HTTPPageGetter,client] Starting factory
 <HTTPClientFactory:
 http://127.0.0.1:6309/uri/URI:DIR2:yodtx22564zgatzzowv765umse:gnlv5ryhwfjvzgqcedx5hlihwrbugh6bd5uiu3vupnsvhqqvq2qa/subdir3/new.txt>
 2012-02-01 01:37:08.736Z [HTTPPageGetter,client] Stopping factory
 <HTTPClientFactory:
 http://127.0.0.1:6309/uri/URI:DIR2:yodtx22564zgatzzowv765umse:gnlv5ryhwfjvzgqcedx5hlihwrbugh6bd5uiu3vupnsvhqqvq2qa/subdir3/big.txt>
 2012-02-01 01:37:09.054Z [HTTPPageGetter,client] Starting factory
 <HTTPClientFactory:
 http://127.0.0.1:6309/uri/URI:DIR2:yodtx22564zgatzzowv765umse:gnlv5ryhwfjvzgqcedx5hlihwrbugh6bd5uiu3vupnsvhqqvq2qa/subdir3/new.txt>
 2012-02-01 01:37:09.055Z [HTTPPageGetter,client] Stopping factory
 <HTTPClientFactory:
 http://127.0.0.1:6309/uri/URI:DIR2:yodtx22564zgatzzowv765umse:gnlv5ryhwfjvzgqcedx5hlihwrbugh6bd5uiu3vupnsvhqqvq2qa/subdir3/new.txt>
 2012-02-01 01:37:09.191Z [HTTPPageGetter,client] Starting factory
 <HTTPClientFactory: http://127.0.0.1:6309/uri>
 2012-02-01 01:37:09.192Z [HTTPPageGetter,client] Stopping factory
 <HTTPClientFactory:
 http://127.0.0.1:6309/uri/URI:DIR2:yodtx22564zgatzzowv765umse:gnlv5ryhwfjvzgqcedx5hlihwrbugh6bd5uiu3vupnsvhqqvq2qa/subdir3/new.txt>
 2012-02-01 01:37:09.583Z [HTTPPageGetter,client] Starting factory
 <HTTPClientFactory: http://127.0.0.1:21595/uri>
 2012-02-01 01:37:09.584Z [HTTPPageGetter,client] Stopping factory
 <HTTPClientFactory: http://127.0.0.1:6309/uri>
 2012-02-01 01:37:10.382Z [HTTPPageGetter,client] Starting factory
 <HTTPClientFactory: http://127.0.0.1:6309/status>
 2012-02-01 01:37:10.383Z [HTTPPageGetter,client] Stopping factory
 <HTTPClientFactory: http://127.0.0.1:21595/uri>
 2012-02-01 01:37:10.433Z [HTTPPageGetter,client] Starting factory
 <HTTPClientFactory: http://127.0.0.1:6309/status/up-229>
 2012-02-01 01:37:10.433Z [HTTPPageGetter,client] Stopping factory
 <HTTPClientFactory: http://127.0.0.1:6309/status/>
 2012-02-01 01:37:10.454Z [HTTPPageGetter,client] Starting factory
 <HTTPClientFactory: http://127.0.0.1:6309/status/down-135>
 2012-02-01 01:37:10.454Z [HTTPPageGetter,client] Stopping factory
 <HTTPClientFactory: http://127.0.0.1:6309/status/up-229>
 2012-02-01 01:37:10.644Z [HTTPPageGetter,client] Starting factory
 <HTTPClientFactory: http://127.0.0.1:6309/status/mapupdate-2143>
 2012-02-01 01:37:10.645Z [HTTPPageGetter,client] Stopping factory
 <HTTPClientFactory: http://127.0.0.1:6309/status/down-135>
 2012-02-01 01:37:10.659Z [HTTPPageGetter,client] Starting factory
 <HTTPClientFactory: http://127.0.0.1:6309/status/publish-890>
 2012-02-01 01:37:10.660Z [HTTPPageGetter,client] Stopping factory
 <HTTPClientFactory: http://127.0.0.1:6309/status/mapupdate-2143>
 2012-02-01 01:37:10.674Z [HTTPPageGetter,client] Starting factory
 <HTTPClientFactory: http://127.0.0.1:6309/status/retrieve-1440>
 2012-02-01 01:37:10.675Z [HTTPPageGetter,client] Stopping factory
 <HTTPClientFactory: http://127.0.0.1:6309/status/publish-890>
 2012-02-01 01:37:10.687Z [HTTPPageGetter,client] Stopping factory
 <HTTPClientFactory: http://127.0.0.1:6309/status/retrieve-1440>
 2012-02-01 01:37:10.687Z [-] (Port 6309 Closed)
 2012-02-01 01:37:10.688Z [-] Stopping factory <nevow.appserver.NevowSite
 instance at 0x21d930ea8>
 2012-02-01 01:37:10.689Z [-] (Port 37699 Closed)
 2012-02-01 01:37:10.690Z [-] (Port 24152 Closed)
 2012-02-01 01:37:10.691Z [-] (Port 21595 Closed)
 2012-02-01 01:37:10.691Z [-] Stopping factory <nevow.appserver.NevowSite
 instance at 0x2085d2ef0>
 2012-02-01 01:37:10.692Z [-] (Port 7049 Closed)
 2012-02-01 01:37:10.693Z [-] (Port 35570 Closed)
 2012-02-01 01:37:10.693Z [-] (Port 7790 Closed)
 2012-02-01 01:37:10.694Z [-] (Port 35768 Closed)
 2012-02-01 01:37:10.695Z [-] (Port 19673 Closed)
 2012-02-01 01:37:10.695Z [-] Stopping factory <nevow.appserver.NevowSite
 instance at 0x21d8becf8>
 2012-02-01 01:37:10.696Z [-] (Port 19624 Closed)
 2012-02-01 01:37:10.708Z [-] Main loop terminated.
 }}}

-- 
Ticket URL: <https://tahoe-lafs.org/trac/tahoe-lafs/ticket/1467#comment:3>
tahoe-lafs <https://tahoe-lafs.org>
secure decentralized storage


More information about the tahoe-lafs-trac-stream mailing list