Hi, my Cassandane tests on the master branch are failing since October 29 and I haven't yet sorted out the root cause.
Since somewhere around commit c3d8f3781071 [1], all test fail with with issues revolving around notifyd. E.g. either writing to a bad file descriptor of the notifyd socket... Message from syslogd@debdev at Nov 10 11:39:51 ... rl exception: Cannot write to pipe: Bad file descriptor#012 at Cassandane/Unit/TestPlan.pm line 174 ...or notifyd blasting messages like the following to syslog: Dec 1 11:04:54 debdev ne BAoIMTIzNDU2NzgECAgIAwcAAAAKBWVycm9yBgAAAHJlc3VsdAoRam1hcF9tdWx0aWNvbnRhY3QIAAAAdGVzdG5hbWUEAgAAAAARAAAAcGFyYW1ldGVyX3NldHRpbmcKDy90bXAvdURmNUFkWHJNdAcAAABsb2dmaWxlBsVwXVYAAAAACgAAA [...] Now, is it just me for whom the master Cassandane tests are broken? Or is any of you also experiencing these issues? Thanks, Robert [1] https://git.cyrus.foundation/rCc3d8f37810716fd98f5f5412ba3cce1043af079d Full log of one of the test runs: =====> Cyrus::TestCase[302] ---------- BEGIN test_user_rename_dom ---------- =====> Cyrus::TestCase[158] Magic attribute AllowMoves sets config allowusermoves = yes =====> Cyrus::TestCase[158] Magic attribute VirtDomains sets config virtdomains = userid =====> Instance[862] start main instance for test test_user_rename_dom: basedir /var/tmp/cass/101443B4 =====> Instance[361] Found binary ctl_cyrusdb in /var/tmp/cyrus/usr/cyrus/sbin =====> Instance[361] Found binary httpd in /var/tmp/cyrus/usr/cyrus/libexec =====> Instance[361] Found binary imapd in /var/tmp/cyrus/usr/cyrus/libexec =====> Instance[774] started saslauthd for /var/tmp/cass/101443B4 as 29039 =====> Instance[1613] opening socket /var/tmp/cass/101443B4/run/mux =====> Instance[801] started notifyd for /var/tmp/cass/101443B4 as 29041 =====> Instance[361] Found binary master in /var/tmp/cyrus/usr/cyrus/libexec =====> Instance[1359] Running: "/var/tmp/cyrus/usr/cyrus/libexec/master" "-C" "/var/tmp/cass/101443B4/conf/imapd.conf" "-l" "255" "-p" "/var/tmp/cass/101443B4/run/master.pid" "-d" "-M" "/var/tmp/cass/101443B4/conf/cyrus.conf" =====> Instance[726] _start_master: waiting for PID file =====> Instance[729] _start_master: PID file present and correct =====> Instance[741] _start_master: PID waiting for services =====> Daemon[356] is_listening: service http is listening on 127.0.0.1:9116 =====> Util::Wait[75] Waited 0.037413 sec for 127.0.0.1:9116 to be in LISTEN state =====> Daemon[356] is_listening: service imap is listening on 127.0.0.1:9117 =====> Instance[752] _start_master: all services listening =====> Instance[828] create user cassandane =====> Util::Socket[61] create_client_socket INET host=127.0.0.1 port=9117 Perl exception: IMAPTalk: IMAP Connection closed by other end: Connection reset by peer at /usr/local/share/perl/5.20.2/Mail/IMAPTalk.pm line 4294. Mail::IMAPTalk::_fill_imap_read_buffer(Mail::IMAPTalk=HASH(0x42f4680), undef, 1) called at /usr/local/share/perl/5.20.2/Mail/IMAPTalk.pm line 4325 Mail::IMAPTalk::_imap_socket_read_line(Mail::IMAPTalk=HASH(0x42f4680)) called at /usr/local/share/perl/5.20.2/Mail/IMAPTalk.pm line 4180 Mail::IMAPTalk::_next_simple_atom(Mail::IMAPTalk=HASH(0x42f4680)) called at /usr/local/share/perl/5.20.2/Mail/IMAPTalk.pm line 3771 Mail::IMAPTalk::_parse_response(Mail::IMAPTalk=HASH(0x42f4680), "", HASH(0x42eaf30)) called at /usr/local/share/perl/5.20.2/Mail/IMAPTalk.pm line 3516 eval {...} called at /usr/local/share/perl/5.20.2/Mail/IMAPTalk.pm line 3510 Mail::IMAPTalk::_imap_cmd(Mail::IMAPTalk=HASH(0x42f4680), "login", 0, "", "admin", HASH(0x42eab58)) called at /usr/local/share/perl/5.20.2/Mail/IMAPTalk.pm line 636 Mail::IMAPTalk::login(Mail::IMAPTalk=HASH(0x42f4680), "admin", "testpw") called at Cassandane/IMAPMessageStore.pm line 108 Cassandane::IMAPMessageStore::connect(Cassandane::IMAPMessageStore=HASH(0x42eaab0)) called at Cassandane/IMAPMessageStore.pm line 285 Cassandane::IMAPMessageStore::get_client(Cassandane::IMAPMessageStore=HASH(0x42eaab0)) called at Cassandane/Instance.pm line 835 Cassandane::Instance::create_user(Cassandane::Instance=HASH(0x42f4098), "cassandane") called at Cassandane/Instance.pm line 886 Cassandane::Instance::start(Cassandane::Instance=HASH(0x42f4098)) called at Cassandane/Cyrus/TestCase.pm line 314 Cassandane::Cyrus::TestCase::_start_instances(Cassandane::Cyrus::Caldav=HASH(0x4328f48)) called at Cassandane/Cyrus/TestCase.pm line 305 Cassandane::Cyrus::TestCase::set_up(Cassandane::Cyrus::Caldav=HASH(0x4328f48)) called at Cassandane/Cyrus/Caldav.pm line 72 Cassandane::Cyrus::Caldav::set_up(Cassandane::Cyrus::Caldav=HASH(0x4328f48)) called at /usr/share/perl5/Test/Unit/TestCase.pm line 58 Test::Unit::TestCase::run_bare(Cassandane::Cyrus::Caldav=HASH(0x4328f48)) called at /usr/share/perl5/Test/Unit/Result.pm line 103 Test::Unit::Result::__ANON__() called at /usr/share/perl5/Test/Unit/Result.pm line 119 Test::Unit::Result::run_protected(Test::Unit::Result=HASH(0x2036f30), Cassandane::Cyrus::Caldav=HASH(0x4328f48), CODE(0x43163c8)) called at /usr/share/perl5/Test/Unit/Result.pm line 107 Test::Unit::Result::run(Test::Unit::Result=HASH(0x2036f30), Cassandane::Cyrus::Caldav=HASH(0x4328f48)) called at /usr/share/perl5/Test/Unit/TestCase.pm line 51 Test::Unit::TestCase::run(Cassandane::Cyrus::Caldav=HASH(0x4328f48), Test::Unit::Result=HASH(0x2036f30), Cassandane::Unit::RunnerPretty=HASH(0x3855f48)) called at /usr/share/perl5/Test/Unit/TestSuite.pm line 278 Test::Unit::TestSuite::run(Test::Unit::TestSuite=HASH(0x2037140), Test::Unit::Result=HASH(0x2036f30), Cassandane::Unit::RunnerPretty=HASH(0x3855f48)) called at Cassandane/Unit/TestPlan.pm line 737 Cassandane::Unit::TestPlan::_run_workitem(Cassandane::Unit::TestPlan=HASH(0x3855d68), HASH(0x4315fd8), Test::Unit::Result=HASH(0x2036f30), Cassandane::Unit::RunnerPretty=HASH(0x3855f48), 0) called at Cassandane/Unit/TestPlan.pm line 846 Cassandane::Unit::TestPlan::__ANON__(HASH(0x4315fd8)) called at Cassandane/Unit/TestPlan.pm line 203 Cassandane::Unit::Worker::_mainloop(Cassandane::Unit::Worker=HASH(0x431fd10)) called at Cassandane/Unit/TestPlan.pm line 164 Cassandane::Unit::Worker::start(Cassandane::Unit::Worker=HASH(0x431fd10)) called at Cassandane/Unit/TestPlan.pm line 305 Cassandane::Unit::WorkerPool::start(Cassandane::Unit::WorkerPool=HASH(0x431fc68)) called at Cassandane/Unit/TestPlan.pm line 850 Cassandane::Unit::TestPlan::run(Cassandane::Unit::TestPlan=HASH(0x3855d68), Test::Unit::Result=HASH(0x2036f30), Cassandane::Unit::RunnerPretty=HASH(0x3855f48)) called at /usr/share/perl5/Test/Unit/TestRunner.pm line 54 Test::Unit::TestRunner::do_run(Cassandane::Unit::RunnerPretty=HASH(0x3855f48), Cassandane::Unit::TestPlan=HASH(0x3855d68), 0) called at ./testrunner.pl line 123 main::__ANON__(Cassandane::Unit::TestPlan=HASH(0x3855d68), GLOB(0x3855e70)) called at ./testrunner.pl line 260 =====> Daemon[385] checking for stray processes on ports: 9116 9117 Test was not successful.
