[Home]

Summary:ASTERISK-01511: TDM400 FXO fxs_ks disconnect supervision
Reporter:kb2ear (kb2ear)Labels:
Date Opened:2004-04-30 16:41:33Date Closed:2004-09-25 02:48:29
Priority:MajorRegression?No
Status:Closed/CompleteComponents:Core/General
Versions:Frequency of
Occurrence
Related
Issues:
Environment:Attachments:
Description:When the remote side of a call hangs up and the PSTN sends a disconnect the FXO port is not responding to it.
Comments:By: Mark Spencer (markster) 2004-04-30 23:15:54

Fixed in CVS
By: kb2ear (kb2ear) 2004-05-01 08:28:10

Updated from CVS, Still not detecting disconnect.

See:
Connected to Asterisk CVS-HEAD-05/01/04-08:05:04 currently running on bgp532528bgs (pid = 1897)
ote UNIX connection
   -- Starting simple switch on 'Zap/5-1'
May  1 08:16:53 NOTICE[1234656048]: chan_zap.c:4703 ss_thread: Got event 2 (Ring/Answered)...
   -- Executing Wait("Zap/5-1", "1") in new stack
   -- Executing Answer("Zap/5-1", "") in new stack
   -- Executing DigitTimeout("Zap/5-1", "5") in new stack
   -- Set Digit Timeout to 5
   -- Executing ResponseTimeout("Zap/5-1", "5") in new stack
   -- Set Response Timeout to 5
   -- Executing SetMusicOnHold("Zap/5-1", "random") in new stack
   -- Executing BackGround("Zap/5-1", "2") in new stack
   -- Playing '2' (language 'en')
   -- Executing BackGround("Zap/5-1", "enter-ext-of-person") in new stack
   -- Playing 'enter-ext-of-person' (language 'en')
   -- Executing BackGround("Zap/5-1", "if-rotary-phone") in new stack
   -- Playing 'if-rotary-phone' (language 'en')
   -- Executing BackGround("Zap/5-1", "to-dial-by-name-press") in new stack
   -- Playing 'to-dial-by-name-press' (language 'en')
   -- Executing BackGround("Zap/5-1", "digits/4") in new stack
   -- Playing 'digits/4' (language 'en')
   -- Executing BackGround("Zap/5-1", "digits/1") in new stack
   -- Playing 'digits/1' (language 'en')
   -- Executing BackGround("Zap/5-1", "digits/1") in new stack
   -- Playing 'digits/1' (language 'en')
   -- Executing BackGround("Zap/5-1", "10") in new stack
   -- Playing '10' (language 'en')
 == CDR updated on Zap/5-1
   -- Executing Goto("Zap/5-1", "default|20|1") in new stack
   -- Goto (default,20,1)
   -- Executing Playback("Zap/5-1", "transfer|skip") in new stack
   -- Playing 'transfer' (language 'en')
   -- Executing Dial("Zap/5-1", "SIP/22&SIP/21&Zap/3&Zap/4&IAX2/kb2ear|30|r") in new stack
   -- Called 22>
May  1 08:17:15 NOTICE[1234656048]: app_dial.c:654 dial_exec: Unable to create channel of type 'SIP'
   -- Called 3I>
   -- Called 4I>
May  1 08:17:15 NOTICE[1234656048]: app_dial.c:654 dial_exec: Unable to create channel of type 'IAX2'
   -- SIP/22-7bbc is ringing
   -- Zap/3-1 is ringing
   -- Zap/4-1 is ringing
   -- Zap/3-1 is ringing
   -- Zap/4-1 is ringing
   -- Zap/3-1 is ringing
   -- Zap/4-1 is ringing
******REMOTE HANG UP HERE**********
   -- Zap/3-1 is ringing
   -- Zap/4-1 is ringing
   -- Zap/3-1 is ringing
   -- Zap/4-1 is ringing
   -- Zap/3-1 is ringing
   -- Zap/4-1 is ringing
   -- Zap/3-1 is ringing
   -- Zap/4-1 is ringing
   -- Nobody picked up in 30000 ms
   -- Hungup 'Zap/4-1'
   -- Hungup 'Zap/3-1'
   -- Executing VoiceMail("Zap/5-1", "21") in new stack
   -- Playing 'vm-intro' (language 'en')
   -- Playing 'beep' (language 'en')
   -- Re-recording the message
   -- x=0, open writing:  /var/spool/asterisk/voicemail/default/21/INBOX/msg0000 format: wav49, 0x8104898
   -- x=1, open writing:  /var/spool/asterisk/voicemail/default/21/INBOX/msg0000 format: gsm, 0x81049b8
   -- x=2, open writing:  /var/spool/asterisk/voicemail/default/21/INBOX/msg0000 format: wav, 0x8104ac8
   -- Playing 'auth-thankyou' (language 'en')
   -- Playing 'vm-review' (language 'en')
   -- Playing 'vm-reachoper' (language 'en')
   -- Playing 'vm-review' (language 'en')
   -- Playing 'vm-reachoper' (language 'en')
   -- Playing 'vm-review' (language 'en')
   -- Playing 'vm-reachoper' (language 'en')
   -- Playing 'vm-review' (language 'en')
   -- Playing 'vm-reachoper' (language 'en')
   -- Playing 'vm-goodbye' (language 'en')
   -- Executing Goto("Zap/5-1", "default|s|1") in new stack
   -- Goto (default,s,1)
   -- Executing Wait("Zap/5-1", "1") in new stack
   -- Executing Answer("Zap/5-1", "") in new stack
   -- Executing DigitTimeout("Zap/5-1", "5") in new stack
   -- Set Digit Timeout to 5
   -- Executing ResponseTimeout("Zap/5-1", "5") in new stack
   -- Set Response Timeout to 5
   -- Executing SetMusicOnHold("Zap/5-1", "random") in new stack
   -- Executing BackGround("Zap/5-1", "2") in new stack
   -- Playing '2' (language 'en')
   -- Executing BackGround("Zap/5-1", "enter-ext-of-person") in new stack
   -- Playing 'enter-ext-of-person' (language 'en')
   -- Executing BackGround("Zap/5-1", "if-rotary-phone") in new stack
   -- Playing 'if-rotary-phone' (language 'en')
   -- Executing BackGround("Zap/5-1", "to-dial-by-name-press") in new stack
   -- Playing 'to-dial-by-name-press' (language 'en')
   -- Executing BackGround("Zap/5-1", "digits/4") in new stack
   -- Playing 'digits/4' (language 'en')
   -- Executing BackGround("Zap/5-1", "digits/1") in new stack
   -- Playing 'digits/1' (language 'en')
   -- Executing BackGround("Zap/5-1", "digits/1") in new stack
   -- Playing 'digits/1' (language 'en')
   -- Executing BackGround("Zap/5-1", "10") in new stack
   -- Playing '10' (language 'en')
   -- Timeout on Zap/5-1
 == CDR updated on Zap/5-1
   -- Executing Playback("Zap/5-1", "current-time-is") in new stack
   -- Playing 'current-time-is' (language 'en')
   -- Executing SayUnixTime("Zap/5-1", "||%A%B%d%y%I%M%P") in new stack
May  1 08:19:53 WARNING[1234656048]: say.c:1246 ast_say_date_with_format: Unknown character in datetime format %A%B%d%y%I%M%P: % at pos 0
   -- Playing 'digits/day-6' (language 'en')
May  1 08:19:54 WARNING[1234656048]: say.c:1246 ast_say_date_with_format: Unknown character in datetime format %A%B%d%y%I%M%P: % at pos 2
   -- Playing 'digits/mon-4' (language 'en')
May  1 08:19:55 WARNING[1234656048]: say.c:1246 ast_say_date_with_format: Unknown character in datetime format %A%B%d%y%I%M%P: % at pos 4
   -- Playing 'digits/h-1' (language 'en')
May  1 08:19:56 WARNING[1234656048]: say.c:1246 ast_say_date_with_format: Unknown character in datetime format %A%B%d%y%I%M%P: % at pos 6
May  1 08:19:56 WARNING[1234656048]: say.c:1246 ast_say_date_with_format: Unknown character in datetime format %A%B%d%y%I%M%P: y at pos 7
May  1 08:19:56 WARNING[1234656048]: say.c:1246 ast_say_date_with_format: Unknown character in datetime format %A%B%d%y%I%M%P: % at pos 8
   -- Playing 'digits/8' (language 'en')
May  1 08:19:56 WARNING[1234656048]: say.c:1246 ast_say_date_with_format: Unknown character in datetime format %A%B%d%y%I%M%P: % at pos 10
   -- Playing 'digits/19' (language 'en')
May  1 08:19:57 WARNING[1234656048]: say.c:1246 ast_say_date_with_format: Unknown character in datetime format %A%B%d%y%I%M%P: % at pos 12
   -- Playing 'digits/a-m' (language 'en')
   -- Executing Playback("Zap/5-1", "eastern") in new stack
   -- Playing 'eastern' (language 'en')
   -- Executing Playback("Zap/5-1", "time") in new stack
   -- Playing 'time' (language 'en')
   -- Executing Playback("Zap/5-1", "your") in new stack
   -- Playing 'your' (language 'en')
   -- Executing Playback("Zap/5-1", "telephone-number") in new stack
   -- Playing 'telephone-number' (language 'en')
   -- Executing SayDigits("Zap/5-1", "7322970469") in new stack
   -- Playing 'digits/7' (language 'en')
   -- Playing 'digits/3' (language 'en')
   -- Playing 'digits/2' (language 'en')
   -- Playing 'digits/2' (language 'en')
   -- Playing 'digits/9' (language 'en')
   -- Playing 'digits/7' (language 'en')
   -- Playing 'digits/0' (language 'en')
   -- Playing 'digits/4' (language 'en')
   -- Playing 'digits/6' (language 'en')
   -- Playing 'digits/9' (language 'en')
   -- Executing Playback("Zap/5-1", "goodbye") in new stack
   -- Playing 'goodbye' (language 'en')
   -- Executing Hangup("Zap/5-1", "") in new stack
 == Spawn extension (default, t, 9) exited non-zero on 'Zap/5-1'
   -- Hungup 'Zap/5-1'
By: kb2ear (kb2ear) 2004-05-01 08:34:40

Zaptel Configuration
======================


Channel map:

Channel 01: FXS Kewlstart (Default) (Slaves: 01)
Channel 02: FXO Kewlstart (Default) (Slaves: 02)
Channel 03: FXO Kewlstart (Default) (Slaves: 03)
Channel 04: FXO Kewlstart (Default) (Slaves: 04)
Channel 05: FXS Kewlstart (Default) (Slaves: 05)

5 channels configured.
By: Mark Spencer (markster) 2004-05-01 09:15:57

zaptel cvs, not asterisk.  It's in there, really.
By: kb2ear (kb2ear) 2004-05-01 09:26:21

I updated both.

-rw-r--r--    1 root     root        51026 May  1 07:57 wcfxs.c
-rw-r--r--    1 root     root         1512 Jul  5  2003 wcfxs.h
-rw-r--r--    1 root     root        35188 May  1 07:59 wcfxs.o

diff -c zaptel2/wcfxs.c zaptel/wcfxs.c
*** zaptel2/wcfxs.c     Sat May  1 07:56:50 2004
--- zaptel/wcfxs.c      Sat May  1 07:57:13 2004
***************
*** 1218,1228 ****
       }
 #endif
       b = wcfxs_getreg(wc, card, 29);
! #if 0
       {
               static int count = 0;
               if (!(count++ % 100)) {
!                       printk("Voltage: %d\n", b);
               }
       }
 #endif
--- 1218,1228 ----
       }
 #endif
       b = wcfxs_getreg(wc, card, 29);
! #if 0
       {
               static int count = 0;
               if (!(count++ % 100)) {
!                       printk("Card %d: Voltage: %d\n", card + 1, b);
               }
       }
 #endif
***************
*** 1274,1279 ****
--- 1274,1281 ----
               /* It's something else... */
               wc->mod.fxo.battdebounce[card] = BATT_DEBOUNCE;
       }
+       if (wc->mod.fxo.battdebounce[card])
+               wc->mod.fxo.battdebounce[card]--;

 }
By: Mark Spencer (markster) 2004-05-01 09:31:10

Okay find me on IRC and I'll ssh in and look.
By: Mark Spencer (markster) 2004-05-01 10:35:13

Whatever the problem was, it's working fine for the user now.  Initial indications would suggest either "make install" or "rmmod wcfxs ; modprobe wcfxs" wasn't executed although the user's update scripts looked fine.