rendered paste bodythe code showing timing injection.
delta_time = time() - self.start_time
log("delta_time(pre pyro init) %s"% delta_time)
arrival = common_services.arrival_DBM()
delta_time = time() - self.start_time
log("delta_time(mid pyro init) %s"% delta_time)
arrival.initialize()
delta_time = time() - self.start_time
log("delta_time(pyro init) %s"% delta_time)
-----------
for common_services.arrival
def __init__(self):
""" """
# really should make a separate initiator to replicate init call
Pyro.core.initClient(banner=0)
self.remote_object = Pyro.core.getProxyForURI("PYRONAME://arrival_DBM")
timing from my code showing a three second delay. Note: these times are cumulative from the beginning of the method.
Oct 11 13:45:57 harvee2pb python: 32312:: postfix_prefilter.py process_rcpttos 164: 1:1: proc_rcpttos ['esj@harvee.org']
Oct 11 13:45:57 harvee2pb python: 32312:: postfix_prefilter.py process_rcpttos 173: 1:1: delta_time(pre pyro init) 0.00242710113525
Oct 11 13:46:00 harvee2pb python: 32312:: postfix_prefilter.py process_rcpttos 178: 1:1: delta_time(mid pyro init) 3.07307600975
Oct 11 13:46:00 harvee2pb python: 32312:: postfix_prefilter.py process_rcpttos 183: 1:1: delta_time(pyro init) 3.08925390244
the output of TCP dump. Around the time of the delay (13:45:57) and there are a series of broadcasts. I have two name servers running both supplying the same services. when I eliminate the second name server, I see the exact same pattern in TCP dump.
13:45:56.856141 arp who-has 192.168.0.31 tell green.harvee.org
13:45:56.857395 IP tpblue.33177 > xeno.harvee.org.domain: 46035+ PTR? 31.0.168.192.in-addr.arpa. (43)
13:45:56.858275 IP xeno.harvee.org.domain > tpblue.33177: 46035 NXDomain* 0/0/0 (43)
13:45:57.144017 IP 192.168.0.31.42184 > tpblue.smtp: S 1850267861:1850267861(0) win 5840 <mss 1460,sackOK,timestamp 43170097 0,nop,wscale 2>
13:45:57.144275 IP tpblue.smtp > 192.168.0.31.42184: S 1645640663:1645640663(0) ack 1850267862 win 5792 <mss 1460,sackOK,timestamp 42365171 43170097,nop,wscale 2>
13:45:57.147902 IP 192.168.0.31.42184 > tpblue.smtp: . ack 1 win 1460 <nop,nop,timestamp 43170098 42365171>
13:45:57.239238 IP tpblue.33177 > xeno.harvee.org.domain: 33944+ PTR? 31.0.168.192.in-addr.arpa. (43)
13:45:57.240219 IP xeno.harvee.org.domain > tpblue.33177: 33944 NXDomain* 0/0/0 (43)
13:45:57.245343 IP tpblue.smtp > 192.168.0.31.42184: P 1:50(49) ack 1 win 1448 <nop,nop,timestamp 42365196 43170098>
13:45:57.246961 IP 192.168.0.31.42184 > tpblue.smtp: . ack 50 win 1460 <nop,nop,timestamp 43170119 42365196>
13:45:57.247835 IP 192.168.0.31.42184 > tpblue.smtp: P 1:19(18) ack 50 win 1460 <nop,nop,timestamp 43170120 42365196>
13:45:57.249146 IP tpblue.smtp > 192.168.0.31.42184: . ack 19 win 1448 <nop,nop,timestamp 42365197 43170120>
13:45:57.251195 IP tpblue.smtp > 192.168.0.31.42184: P 50:159(109) ack 19 win 1448 <nop,nop,timestamp 42365197 43170120>
13:45:57.253779 IP 192.168.0.31.42184 > tpblue.smtp: P 19:65(46) ack 159 win 1460 <nop,nop,timestamp 43170123 42365197>
13:45:57.291197 IP tpblue.smtp > 192.168.0.31.42184: . ack 65 win 1448 <nop,nop,timestamp 42365208 43170123>
13:45:57.294817 IP tpblue.smtp > 192.168.0.31.42184: P 159:167(8) ack 65 win 1448 <nop,nop,timestamp 42365208 43170123>
13:45:57.296723 IP 192.168.0.31.42184 > tpblue.smtp: P 65:91(26) ack 167 win 1460 <nop,nop,timestamp 43170144 42365208>
13:45:57.296842 IP tpblue.smtp > 192.168.0.31.42184: . ack 91 win 1448 <nop,nop,timestamp 42365209 43170144>
13:45:57.396905 IP tpblue.33177 > 255.255.255.255.9090: UDP, length 8
13:45:57.398397 IP tpblue.33177 > 255.255.255.255.9091: UDP, length 8
13:45:58.152129 IP tpblue.33177 > 255.255.255.255.9090: UDP, length 8
13:45:58.152515 IP tpblue.33177 > 255.255.255.255.9091: UDP, length 8
13:45:58.184533 802.1d config 8000.00:12:25:55:f3:ec.8001 root 8000.00:12:25:55:f3:ec pathcost 0 age 0 max 20 hello 2 fdelay 0
13:45:58.908481 IP tpblue.33177 > 255.255.255.255.9090: UDP, length 8
13:45:58.911615 IP tpblue.33177 > 255.255.255.255.9091: UDP, length 8
13:45:59.663736 IP tpblue.33177 > 255.255.255.255.9090: UDP, length 8
13:45:59.664142 IP tpblue.33177 > 255.255.255.255.9091: UDP, length 8
13:46:00.179822 802.1d config 8000.00:12:25:55:f3:ec.8001 root 8000.00:12:25:55:f3:ec pathcost 0 age 0 max 20 hello 2 fdelay 0
13:46:00.468770 IP tpblue.58818 > xeno.harvee.org.smtp: S 1649267519:1649267519(0) win 5840 <mss 1460,sackOK,timestamp 42366002 0,nop,wscale 2>
13:46:00.469558 IP xeno.harvee.org.smtp > tpblue.58818: S 58445807:58445807(0) ack 1649267520 win 5792 <mss 1460,sackOK,timestamp 376476773 42366002,nop,wscale 2>