Mantis Bugtracker

Viewing Issue Simple Details Jump to Notes ] View Advanced ] Issue History ] Print ]
ID Category Severity Reproducibility Date Submitted Last Update
0000040 [MyDNS-NG] Global major random 2009-12-15 10:07 2009-12-22 10:26
Reporter tlamy View Status public  
Assigned To tlamy
Priority normal Resolution fixed  
Status resolved   Product Version 1.2.8.27
Summary 0000040: Not responding to any request after a while
Description mydns stops responding very quickly after start. Logfile reports dying server processes.

Already reported on -devel by Paul J. Smith [pjsmith@mtgsy.net] on 2009-09-17, reasked on 2009-10-26
Additional Information Dec 15 10:59:04 admin mydns[6138]: Server pid 6140 died
Dec 15 10:59:04 admin mydns[8351]: purge_bad_task() bad task 0.0.0.0: 000 (22) NEED_TASK_READ, High Priority IO Driven Task => 2
Dec 15 11:00:07 admin mydns[6142]: terminated
Dec 15 11:00:07 admin mydns[6142]: admin up 10m8s (608s) 2374 questions (4/s) NOERROR=807 SERVFAIL=0 NXDOMAIN=1566 NOTIMP=0 REFUSED=0 (0% TCP, 6 queries)
Dec 15 11:00:07 admin mydns[8351]: terminated
Dec 15 11:00:07 admin mydns[8351]: admin up 10m8s (608s) 25 questions (0/s) NOERROR=24 SERVFAIL=0 NXDOMAIN=0 NOTIMP=0 REFUSED=0 (4% TCP, 1 queries)
Dec 15 11:00:07 admin mydns[6138]: Server pid 8351 died
Dec 15 11:00:07 admin mydns[8585]: terminated
Dec 15 11:00:07 admin mydns[8585]: admin up 10m8s (608s) 27 questions (0/s) NOERROR=24 SERVFAIL=0 NXDOMAIN=0 NOTIMP=0 REFUSED=0 (3% TCP, 1 queries)
Dec 15 11:00:07 admin mydns[6138]: Server pid 6142 died
Dec 15 11:00:07 admin mydns[6138]: Server pid 8585 died
Dec 15 11:00:07 admin mydns[6138]: terminated
Dec 15 11:00:07 admin mydns[6138]: admin up 10m8s (608s) 25 questions (0/s) NOERROR=23 SERVFAIL=0 NXDOMAIN=0 NOTIMP=0 REFUSED=0
Tags No tags attached.
Attached Files zip file icon bug40.zip [^] (2,259 bytes) 2009-12-22 10:18

- Relationships

-  Notes
(0000109)
tlamy (developer)
2009-12-15 10:21

Rebuilt with debugging symbols on the same machine mydns is running (previous version was built on a different machine), this seems to have fixed the issue. Somewhat strange however.
(0000110)
tlamy (developer)
2009-12-15 10:43
edited on: 2009-12-15 10:44

Recompile did not fix, but slow down the issue.
Now mydns-ng runs for about 10 minutes before stalling.

From the log:
mydns[32424]: 15-Dez-2009 11:39:03+564973 #1944 35090 UDP 115.73.163.34 IN A mx.in-online.net. NOERROR - 1 3 2 2 LOG N QUERY ""
mydns[32424]: 15-Dez-2009 11:39:03+898946 #1945 35296 UDP 82.208.45.162 IN A mx.in-online.net. NOERROR - 1 3 2 2 LOG N QUERY ""
mydns[32424]: 15-Dez-2009 11:39:03+908040 #1946 35336 UDP 82.208.45.162 IN A mail.mvg.de. NOERROR - 1 1 2 2 LOG N QUERY ""
mydns[32424]: Normal shutdown
mydns[32424]: admin up 1m48s (108s) 531 questions (5/s) NOERROR=512 SERVFAIL=0 NXDOMAIN=15 NOTIMP=0 REFUSED=0 (0% TCP, 3 queries)
mydns[32424]: 15-Dez-2009 11:39:04+116858 0000001 0 UDP 0.0.0.0 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
mydns[32424]: 15-Dez-2009 11:39:04+116885 #1947 64941 UDP 201.17.0.14 IN MX temic-hf.de. NOERROR - 1 1 2 3 LOG N QUERY ""
mydns[32424]: 15-Dez-2009 11:39:04+116909 0000003 0 UDP Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
mydns[32424]: 15-Dez-2009 11:39:04+116932 #0 0 UNKNOWN Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
mydns[32419]: 15-Dez-2009 11:39:16+249352 0000002 0 UDP Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""

(0000111)
tlamy (developer)
2009-12-15 11:42

Moreinfo:
This seems to be related to clock jumps on the vmware guest I'm running.

I replaced the child shutdown in src/mydns/servercomms.c:409 with a warning, will report how this works.
(0000112)
tlamy (developer)
2009-12-15 12:21

Success, avoided at least 4 child shutdowns after 30 minutes.

For others running in a vmware guest, see http://kb.vmware.com/selfservice/microsites/search.do?language=en_US&cmd=displayKC&externalId=1006427 [^] on how to avoid clock jumps.

This bug is still pending, as the master does not correctly react on dying childs.
(0000113)
pjsmith (reporter)
2009-12-16 13:34

I'll add my previous notes here as it'll help keep possibly useful info together on this bug. BTW - I've noticed this is certainly often caused by load, or slow performance in answering db queries from the mysql server. I have reduced the problem by allocating a large table query cache on the mysql servers to decrease response time to the mydns servers.


>
> I've noticed a possible pattern to these lock ups. I seen
> that this can be experienced when the mysql database is slow,
> i.e. optimise a big rr table on a live server so that mysql
> doesn't repsond quickly to mydns. Perhaps mydns runs out of
> buffers with all those queries coming in?
>
> The list seems to have gone very quiet. Is development still
> proceeding?
>
> -----Original Message-----
> From: Paul J. Smith [mailto:pjsmith@mtgsy.net]
> Sent: 17 September 2009 10:16
> To: mydns-ng-devel@lists.sourceforge.net
> Subject: Re: [Mydns-ng-devel] MyDNS Refuses query's after some time
>
> Hi howard,
>
> Did you get my last at all regarding the same sort of issues?
> Got so bad I have written a script to test all servers every
> 60 seconds and restart as needed!
>
> "
> Hi,
>
> Not sure why yet, but one of my mydns servers has started
> failing ever couple hours or so. I have some log data,
> before the failt, during, and after I 'killed' the parent
> process. Posting it here in case it helps resolve the issue
> with the mydns server as I'm pretty sure this is a bug of some sort.
>
> Notes : Where is says ' mydns[30907]: mydns: Normal
> shutdown', I did in fact not shut down the server at all!
> The doman names have been XXX'd just for privacy reasons
> You can see my full command history as well and the part of
> the log before, during, and after the issue occurs.
>
> I've been seeing this with all versions of mydnsng, though I
> normally get it about once a week. Now for some reason it's
> started happening very reguarly. I guess it may be reacting
> bad to some data, and I've tried to clean up any issues, but
> it's still choking on somthing.
>
> mydns[30917]: mydns: 01-Sep-2009 19:29:01+041638 #8323 37937
> UDP 190.19.213.167 IN MX xxxxx.com. NOERROR - 1 2 4 6 LOG Y QUERY ""
> mydns[30917]: mydns: 01-Sep-2009 19:29:01+097508 #8324 30930
> UDP 92.52.71.238 IN A 53.86.102.200.xxxxx.com. NXDOMAIN
> No_matching_resource_records 1 0 1 0 LOG N QUERY ""
> mydns[30917]: mydns: 01-Sep-2009 19:29:01+107468 #8325 30570
> UDP 194.72.0.98 IN A www.xxxxx.com. NOERROR - 1 1 6 6 LOG N QUERY ""
> mydns[30917]: mydns: 01-Sep-2009 19:29:01+114447 #8326 51909
> UDP 212.159.6.129 IN A online.xxxxxx.uk. NOERROR - 1 0 2 0
> LOG Y QUERY ""
> mydns[30907]: mydns: Normal shutdown
> mydns[30907]: mydns: mysql2 up 15h18m20s (55100s) 3745
> questions (0/s) NOERROR=3553 SERVFAIL=0 NXDOMAIN=184 NOTIMP=0
> REFUSED=0 (0% TCP, 3 queries)
> mydns[30907]: mydns: 01-Sep-2009 19:31:05+034437 #5661 0 UDP
> 0.0.0.0 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30907]: mydns: 01-Sep-2009 19:31:05+034487 #5662 0 UDP
> 0.0.0.0 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30907]: mydns: 01-Sep-2009 19:31:05+034515 #5663 0 UDP
> :: 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30907]: mydns: 01-Sep-2009 19:31:05+034626 #9300 11969
> UDP 83.8.74.114 IN A xxxxxxx.com. NOERROR - 1 0 1 0 LOG N QUERY ""
> mydns[30907]: mydns: 01-Sep-2009 19:31:05+034657 #5721 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30907]: mydns: 01-Sep-2009 19:31:05+034681 #5660 0
> UNKNOWN Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30917]: mydns: Normal shutdown
> mydns[30917]: mydns: mysql2 up 15h18m20s (55100s) 3494
> questions (0/s) NOERROR=3324 SERVFAIL=0 NXDOMAIN=162 NOTIMP=0
> REFUSED=0 (0% TCP, 3 queries)
> mydns[30917]: mydns: 01-Sep-2009 19:31:05+068643 #5662 0 UDP
> 0.0.0.0 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30917]: mydns: 01-Sep-2009 19:31:05+068983 #5663 0 UDP
> 0.0.0.0 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30917]: mydns: 01-Sep-2009 19:31:05+069012 #5664 0 UDP
> :: 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30917]: mydns: 01-Sep-2009 19:31:05+069050 #8327 8626
> UDP 86.35.14.43 IN MX xxxxxxxxx.tv. NOERROR - 1 4 6 9 LOG N QUERY ""
> mydns[30917]: mydns: 01-Sep-2009 19:31:05+069085 #5728 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30917]: mydns: 01-Sep-2009 19:31:05+069110 #5661 0
> UNKNOWN Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30907]: mydns: terminated
> mydns[30907]: mydns: mysql2 up 15h18m38s (55118s) 3745
> questions (0/s) NOERROR=3562 SERVFAIL=0 NXDOMAIN=184 NOTIMP=0
> REFUSED=0 (0% TCP, 3 queries)
> mydns[30917]: mydns: terminated
> mydns[30917]: mydns: mysql2 up 15h18m38s (55118s) 3494
> questions (0/s) NOERROR=3333 SERVFAIL=0 NXDOMAIN=162 NOTIMP=0
> REFUSED=0 (0% TCP, 3 queries)
> mydns[7197]: mydns: Server pid 30907 died
> mydns[7197]: mydns: 01-Sep-2009 19:31:23+270655 #5660 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30984]: mydns: 01-Sep-2009 19:31:23+275718 #5661 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: Server pid 30917 died
> mydns[7197]: mydns: 01-Sep-2009 19:31:23+280569 #5661 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30986]: mydns: 01-Sep-2009 19:31:23+286556 #5662 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30984]: mydns: purge_bad_task() bad task 0.0.0.0: 000
> (5663) NEED_TASK_READ, High Priority IO Driven Task => 2
> mydns[30984]: mydns: 01-Sep-2009 19:31:23+296702 #5663 0 UDP
> 0.0.0.0 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30984]: mydns: purge_bad_task() bad task 0.0.0.0: 000
> (5664) NEED_TASK_READ, High Priority IO Driven Task => 4
> mydns[30984]: mydns: 01-Sep-2009 19:31:23+297676 #5664 0 UDP
> 0.0.0.0 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30984]: mydns: purge_bad_task() bad task ::: 000
> (5696) NEED_TASK_READ, High Priority IO Driven Task => 6
> mydns[30984]: mydns: 01-Sep-2009 19:31:23+298592 #5696 0 UDP
> :: 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30984]: mydns: 01-Sep-2009 19:31:23+298617 #5710 0 TCP
> 0.0.0.0 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30984]: mydns: 01-Sep-2009 19:31:23+298643 #5721 0 TCP
> 0.0.0.0 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30984]: mydns: 01-Sep-2009 19:31:23+298785 #5728 0 TCP
> :: 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30986]: mydns: purge_bad_task() bad task 0.0.0.0: 000
> (5664) NEED_TASK_READ, High Priority IO Driven Task => 2
> mydns[30986]: mydns: 01-Sep-2009 19:31:23+302770 #5664 0 UDP
> 0.0.0.0 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30986]: mydns: purge_bad_task() bad task 0.0.0.0: 000
> (5696) NEED_TASK_READ, High Priority IO Driven Task => 4
> mydns[30986]: mydns: 01-Sep-2009 19:31:23+302821 #5696 0 UDP
> 0.0.0.0 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30986]: mydns: purge_bad_task() bad task ::: 000
> (5710) NEED_TASK_READ, High Priority IO Driven Task => 6
> mydns[30986]: mydns: 01-Sep-2009 19:31:23+302861 #5710 0 UDP
> :: 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30986]: mydns: 01-Sep-2009 19:31:23+302882 #5721 0 TCP
> 0.0.0.0 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30986]: mydns: 01-Sep-2009 19:31:23+302906 #5728 0 TCP
> 0.0.0.0 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30986]: mydns: 01-Sep-2009 19:31:23+302928 #5760 0 TCP
> :: 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:32:48+186769 #5664 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:32:48+187609 #5665 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30984]: mydns: 01-Sep-2009 19:32:48+187740 #5767 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30986]: mydns: 01-Sep-2009 19:32:48+188483 #5768 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30984]: mydns: 01-Sep-2009 19:33:36+102720 #5792 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:33:36+103613 #5666 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:33:36+103670 #5667 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30986]: mydns: 01-Sep-2009 19:33:36+103774 #5769 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30986]: mydns: 01-Sep-2009 19:34:27+003783 #5770 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:34:27+004236 #5668 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:34:27+004327 #5669 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30984]: mydns: 01-Sep-2009 19:34:27+004670 #5793 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30986]: mydns: 01-Sep-2009 19:35:45+907911 #5771 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30984]: mydns: 01-Sep-2009 19:35:45+908275 #5794 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:35:45+908481 #5670 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:35:45+908570 #5671 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30984]: mydns: 01-Sep-2009 19:36:35+755505 #5795 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:36:35+755958 #5672 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:36:35+756015 #5673 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30986]: mydns: 01-Sep-2009 19:36:35+756319 #5772 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30984]: mydns: 01-Sep-2009 19:37:24+661029 #5796 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30986]: mydns: 01-Sep-2009 19:37:24+661244 #5773 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:37:24+661985 #5674 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:37:24+662046 #5675 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30984]: mydns: 01-Sep-2009 19:38:44+564114 #5797 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30986]: mydns: 01-Sep-2009 19:38:44+564821 #5774 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:38:44+565073 #5676 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:38:44+565147 #5677 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30984]: mydns: 01-Sep-2009 19:39:35+444587 #5798 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30986]: mydns: 01-Sep-2009 19:39:35+444780 #5775 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:39:35+445543 #5678 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:39:35+445600 #5679 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30984]: mydns: 01-Sep-2009 19:40:24+356429 #5799 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30986]: mydns: 01-Sep-2009 19:40:24+356813 #5776 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:40:24+357105 #5680 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:40:24+357188 #5681 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:41:47+253533 #5682 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:41:47+253678 #5683 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30984]: mydns: 01-Sep-2009 19:41:47+254343 #5800 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30986]: mydns: 01-Sep-2009 19:41:47+254662 #5777 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:42:34+165976 #5684 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:42:34+166114 #5685 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30984]: mydns: 01-Sep-2009 19:42:34+166591 #5801 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30986]: mydns: 01-Sep-2009 19:42:34+167002 #5778 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30984]: mydns: 01-Sep-2009 19:43:25+057740 #5802 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:43:25+057931 #5686 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:43:25+057983 #5687 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30986]: mydns: 01-Sep-2009 19:43:25+058637 #5779 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30984]: mydns: 01-Sep-2009 19:44:43+914291 #5803 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:44:43+914847 #5688 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:44:43+914900 #5689 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30986]: mydns: 01-Sep-2009 19:44:43+915276 #5780 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30984]: mydns: 01-Sep-2009 19:45:34+823492 #5804 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30986]: mydns: 01-Sep-2009 19:45:34+824321 #5781 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:45:34+824497 #5690 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:45:34+824556 #5691 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30984]: mydns: 01-Sep-2009 19:46:23+717721 #5805 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:46:23+718164 #5692 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:46:23+718392 #5693 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30986]: mydns: 01-Sep-2009 19:46:23+718567 #5782 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30984]: mydns: 01-Sep-2009 19:47:44+635639 #5806 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:47:44+636578 #5694 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:47:44+636632 #5695 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30986]: mydns: 01-Sep-2009 19:47:44+636723 #5783 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30984]: mydns: 01-Sep-2009 19:48:33+550720 #5807 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:48:33+551136 #5696 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:48:33+551187 #5697 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30986]: mydns: 01-Sep-2009 19:48:33+551419 #5784 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30984]: mydns: 01-Sep-2009 19:49:24+427511 #5808 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:49:24+428356 #5698 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:49:24+428409 #5699 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30986]: mydns: 01-Sep-2009 19:49:24+429494 #5785 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30984]: mydns: 01-Sep-2009 19:50:43+334578 #5809 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:50:43+334935 #5700 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:50:43+335579 #5701 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30986]: mydns: 01-Sep-2009 19:50:43+336432 #5786 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> [root@mysql2 ~]# ps ax | grep mydns
> 7200 ? Ss 0:02 mydns -b -v
> 30984 ? S 0:00 mydns -b -v
> 30986 ? S 0:00 mydns -b -v
> 32399 pts/0 S+ 0:00 grep mydns
> [root@mysql2 ~]# kill 7200
> [root@mysql2 ~]# ps ax | grep mydns
> 32409 pts/0 S+ 0:00 grep mydns
> [root@mysql2 ~]# tail /var/log/mydns
> mydns[7197]: mydns: 01-Sep-2009 19:52:31+346171 #5662 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[7197]: mydns: 01-Sep-2009 19:52:31+346580 #5663 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30986]: mydns: terminated
> mydns[30986]: mydns: mysql2 up 15h39m46s (56386s) 2254
> questions (0/s) NOERROR=2253 SERVFAIL=0 NXDOMAIN=0 NOTIMP=0
> REFUSED=0 (0% TCP, 3 queries)
> mydns[30986]: mydns: 01-Sep-2009 19:52:31+348255 #5767 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30984]: mydns: terminated
> mydns[30984]: mydns: mysql2 up 15h39m46s (56386s) 2253
> questions (0/s) NOERROR=2252 SERVFAIL=0 NXDOMAIN=0 NOTIMP=0
> REFUSED=0 (0% TCP, 3 queries)
> mydns[30984]: mydns: 01-Sep-2009 19:52:31+349067 #5760 0 UDP
> Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30984]: mydns: 01-Sep-2009 19:52:31+349152 #5662 0
> UNKNOWN Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> mydns[30986]: mydns: 01-Sep-2009 19:52:31+355921 #5663 0
> UNKNOWN Address unknown 000 000 NOERROR - 0 0 0 0 LOG N QUERY ""
> [root@mysql2 ~]# mydns -b -v
> [root@mysql2 ~]#
> [root@mysql2 ~]# mydns --version
> mydns (mydns) 1.2.8.27 (MySQL 5.0.27)
>
> Copyright (C) 2002-2005 Don Moore 2007-2008 Howard Wilkinson
> This is free software; see the source for copying conditions.
> There is NO
> warranty; not even for MERCHANTABILITY or FITNESS FOR A
> PARTICULAR PURPOSE.
>
>
> I hope this might give a bit of info to help solve the
> problem. Let me know if you need anything else.
>
> my conf is
>
> db-host = 127.0.0.1 # SQL server hostname
> db-user = root # SQL server username
>
>
> # GENERAL OPTIONS
>
> user = nobody # Run with the permissions of
> this user
> group = nobody # Run with the permissions of
> this group
> listen = * # Listen on these addresses
> ('*' for all)
>
>
> # CACHE OPTIONS
>
> zone-cache-size = 16384 # Maximum number of elements
> stored in the zone cache
> zone-cache-expire = 60 # Number of seconds after
> which cached zones expires
> reply-cache-size = 16384 # Maximum number of elements
> stored in the reply cache
> reply-cache-expire = 30 # Number of seconds after
> which cached replies expire
>
>
> # ESOTERICA
>
> #log = LOG_DAEMON # Facility to use for program
> output (LOG_*/stdout/stderr)
> log = /var/log/mydns # Facility to use for
> program output
> (LOG_*/stdout/stderr)
> pidfile = /var/run/mydns.pid # Path to PID file
> timeout = 60 # Number of seconds after
> which queries time out
> multicpu = 2 # Number of CPUs installed on
> your system
> allow-axfr = yes # Should AXFR be enabled?
> allow-tcp = yes # Should TCP be enabled?
> ignore-minimum = yes # Ignore minimum TTL for zone?
> soa-table = soa # Name of table containing SOA records
> rr-table = rr # Name of table containing RR data
>
>
> Regards,
>
> Paul
>
(0000114)
pjsmith (reporter)
2009-12-16 13:37

It's interesting to note what you say about virtual. For info, most of my 8+ servers that all exhibit this behaviour are virtualised on various platforms.
(0000122)
tlamy (developer)
2009-12-16 16:58

Produced a quick fix, jpsmith is willing to test
(0000126)
tlamy (developer)
2009-12-21 08:57

The fix just masks the real problem, where mydns-ng does not recover properly when one child dies.
Still looking into this.
(0000127)
tlamy (developer)
2009-12-22 10:26

With the attached patch, mydns-ng properly responds to queries after a server child dies for whatever reason.
Also included a workaround for jumping system clocks, as observed in some virtual machine setups. This would emit a Notice to syslog about clock jump (fairly often on loaded servers, please fix your guest system setup).

- Issue History
Date Modified Username Field Change
2009-12-15 10:07 tlamy New Issue
2009-12-15 10:21 tlamy Note Added: 0000109
2009-12-15 10:43 tlamy Note Added: 0000110
2009-12-15 10:44 tlamy Note Edited: 0000110
2009-12-15 11:42 tlamy Note Added: 0000111
2009-12-15 12:21 tlamy Note Added: 0000112
2009-12-15 12:52 tlamy Issue Monitored: tlamy
2009-12-16 13:34 pjsmith Note Added: 0000113
2009-12-16 13:37 pjsmith Note Added: 0000114
2009-12-16 16:58 tlamy Note Added: 0000122
2009-12-16 16:58 tlamy Assigned To => tlamy
2009-12-16 16:58 tlamy Status new => assigned
2009-12-21 08:57 tlamy Note Added: 0000126
2009-12-21 08:57 tlamy Status assigned => confirmed
2009-12-22 10:18 tlamy File Added: bug40.zip
2009-12-22 10:26 tlamy Note Added: 0000127
2009-12-22 10:26 tlamy Status confirmed => resolved
2009-12-22 10:26 tlamy Resolution open => fixed


Mantis 1.1.6[^]
Copyright © 2000 - 2008 Mantis Group
Powered by Mantis Bugtracker