Koozali.org: home of the SME Server

Modem trouble ISDN

kristallix

Modem trouble ISDN
« on: April 17, 2002, 06:32:22 PM »
Hi,

I've posted some time ago but same problem still exists. I wrote this:

> I could use some advice concerning my ISDN (internal pci) modem. Just bought > a Safeway winbond modem. The modem is recognized bij sme 5.1.2 but causes > trouble when working. Internet/e-mail facilities dont work after a while. When i
> reboot te server the system goes down and i see this message:
>
>ISDN Hisax ch0 cause E0010
>
> The trouble is, i bought this modem because others are working with it and
> seem to be happy. I have not altered templates but i have added Stephen
> Noble's multipop noarch. (no error messages as far as i see)
>
>any tips/solutions are welcome!

The sever is working as a file/printerserver now...we want e-mai/internet!!

Please help. I have this time prepared a piece of log (see under).

I've been offered help but that hasnt materialized yet. RequestedDeletion tells me that there is no active ISDN line. The ISDN line is working ok. The server does something wrong (probably I did ;)) How can i fix this so i have a stable email/internet line???



14:11:21 serv rc: Starting smtpfwdd:  succeeded
14:11:22 serv httpd-e-smith: Starting httpd:
14:11:28 serv httpd-e-smith: httpd startup succeeded
14:11:28 serv httpd-e-smith:
14:11:30 serv rc: Starting httpd-e-smith:  succeeded
14:11:30 serv sshd: Starting sshd:
14:11:30 serv sshd:  succeeded
14:11:30 serv sshd: ^[[60G
14:11:30 serv sshd[1194]: Server listening on 192.168.240.1 port 22.
14:11:31 serv sshd:
14:11:31 serv rc: Starting sshd:  succeeded
14:11:32 serv httpd-admin: Starting httpd-admin:
14:11:35 serv httpd-admin: httpd-admin startup succeeded
14:11:35 serv httpd-admin: ^[[60G
14:11:35 serv httpd-admin:
14:11:37 serv rc: Starting httpd-admin:  succeeded
14:11:38 serv mysqld: Starting MySQL:  
14:11:38 serv mysqld: Starting MySQL:  succeeded
14:11:38 serv mysqld: ^[[60G
14:11:38 serv mysqld:
14:11:38 serv rc: Starting mysqld:  succeeded
14:11:39 serv squid: Starting squid:
14:11:39 serv squid:
14:11:39 serv rc: Starting squid:  succeeded
14:11:40 serv squid[1436]: Squid Parent: child process 1437 started
14:11:40 serv kernel: NET4: AppleTalk 0.18 for Linux NET4.0
14:11:40 serv atalk: Starting AppleTalk services:
14:11:40 serv atalk: (backgrounded)
14:11:40 serv rc: Starting atalk:  succeeded
14:11:41 serv atalkd[1458]: restart (1.5pre7)
14:11:41 serv smb: Starting SMB services:
14:11:42 serv atalkd[1458]: zip_getnetinfo for eth0
14:11:45 serv smb: smbd startup succeeded
14:11:45 serv smb: ^[[60G
14:11:45 serv smb:
14:11:45 serv smb: Starting NMB services:
14:11:46 serv smb: nmbd startup succeeded
14:11:46 serv smb: ^[[60G
14:11:46 serv smb:
14:11:46 serv rc: Starting smb:  succeeded
14:11:48 serv e-smith[1491]: Processing event: local
14:11:48 serv e-smith[1491]: Running event handler: /etc/e-smith/events/local/S10module-load-usb-printer
14:11:50 serv kernel: usb.c: registered new driver usblp
14:11:50 serv e-smith[1491]: S10module-load-usb-printer=action|Event|local|Action|S10module-load-usb-printer|Start|1017835908 867758|End|1017835910 672570|Elapsed|1.804812
14:11:51 serv mysql.init: Loading data into mysql
14:11:51 serv mysql.init: Loading data into mysql succeeded
14:11:51 serv mysql.init: ^[[60G
14:11:51 serv mysql.init:
14:11:51 serv rc: Starting mysql.init:  succeeded
14:11:51 serv atalkd[1458]: zip_getnetinfo for eth0
12:11:51 serv named[292]: named shutting down
12:11:51 serv named[1526]: starting (/etc/named.conf).  named 8.2.4-REL Mon May 28 13:52:41 EDT 2001 ^Icharlieb@lamington:/home/e-smith/files/ibays/development/files/users/charlieb/rpms/BUILD/bind-8.2.4/src/bin/named
12:11:51 serv named[1526]: hint zone "" (IN) loaded (serial 0)
12:11:51 serv named[1526]: master zone "0.0.127.in-addr.arpa" (IN) loaded (serial 1997022700)
14:11:52 serv diald[870]: Trigger: udp     192.168.240.1/1024    192.203.230.10/53  
14:11:52 serv diald[870]: Calling site 0.0.0.0
12:11:51 serv named[1526]: master zone "localhost" (IN) loaded (serial 42)
12:11:51 serv named[1526]: master zone "240.168.192.in-addr.arpa" (IN) loaded (serial 2002030600)
12:11:51 serv named[1526]: master zone "mijndomein.com" (IN) loaded (serial 2002030600)
12:11:52 serv named[1526]: listening on [127.0.0.1].53 (lo)
12:11:52 serv named[1526]: listening on [192.168.240.1].53 (eth0)
12:11:52 serv named[1526]: Forwarding source address is [0.0.0.0].1024
12:11:52 serv named[1526]: chrooted to /home/dns
12:11:52 serv named[1526]: group = dns
12:11:52 serv named[1526]: user = dns
12:11:52 serv named[1526]: Ready to answer queries.
14:11:53 serv kernel: ippp0: dialing 1 03783333...
14:11:55 serv ipppd[838]: Local number: 0, Remote number: 03783333, Type: outgoing
14:11:55 serv ipppd[838]: PHASE_WAIT -> PHASE_ESTABLISHED, ifunit: 0, linkunit: 0, fd: 7
14:11:55 serv ipppd[838]: sent
  • [LCP ConfReq id=0x1 ]

14:11:55 serv kernel: isdn_net: ippp0 connected
14:11:55 serv ipppd[838]: rcvd
  • [LCP ConfReq id=0x1 ]

14:11:55 serv ipppd[838]: sent
  • [LCP ConfAck id=0x1 ]

14:11:55 serv ipppd[838]: rcvd
  • [LCP ConfAck id=0x1 ]

14:11:55 serv ipppd[838]: lcp layer is UP
14:11:55 serv ipppd[838]: ioctl(SIOCSIFMTU): Invalid argument, 6 ippp0 1524.
14:11:55 serv ipppd[838]: rcvd
  • [CHAP Challenge id=0x1 , name = "NLUDS0AH50"]

14:11:55 serv ipppd[838]: ChapReceiveChallenge: Rcvd id 1.
14:11:55 serv ipppd[838]: ChapReceiveChallenge: received name field: 'NLUDS0AH50'
14:11:55 serv ipppd[838]: sent
  • [CHAP Response id=0x1 <65b2f477f73b0b87f79d663274367a2c>, name = "inlognaam"]

14:11:55 serv ipppd[838]: rcvd
  • [CHAP Success id=0x1 ",MB("Welkom bij Planet Internet","Welkom",i);"]

14:11:55 serv ipppd[838]: ChapReceiveSuccess: Rcvd id 1.
14:11:55 serv ipppd[838]: Remote message: ,MB("Welkom bij Planet Internet","Welkom",i);
14:11:55 serv ipppd[838]: MPPP negotiation, He: No We: No
14:11:55 serv ipppd[838]: sent
  • [IPCP ConfReq id=0x1 ]

14:11:55 serv ipppd[838]: CCP enabled! Trying CCP.
14:11:55 serv ipppd[838]: CCP: got ccp-unit 0 for link 0 (Compression Control Protocol)
14:11:55 serv ipppd[838]: ccp_resetci!
14:11:55 serv ipppd[838]: rcvd
  • [IPCP ConfReq id=0x1 ]

14:11:55 serv ipppd[838]: sent
  • [IPCP ConfRej id=0x1 ]

14:11:55 serv ipppd[838]: rcvd
  • [IPCP ConfNak id=0x1 ]

14:11:56 serv ipppd[838]: sent
  • [IPCP ConfReq id=0x2 ]

14:11:56 serv ipppd[838]: rcvd
  • [IPCP ConfReq id=0x2 ]

14:11:56 serv ipppd[838]: sent
  • [IPCP ConfAck id=0x2 ]

14:11:56 serv ipppd[838]: rcvd
  • [IPCP ConfAck id=0x2 ]

14:11:56 serv ipppd[838]: local  IP address 195.121.129.249
14:11:56 serv ipppd[838]: remote IP address 193.172.250.31
14:11:56 serv diald[870]: connector: Interface up: host indeterminate
14:11:56 serv diald[870]: Connected to site 0.0.0.0
14:11:56 serv diald[870]: Open device ippp0
14:11:56 serv diald[870]: New addresses: local 195.121.129.249, remote 193.172.250.31, broadcast 0.0.0.0
14:11:58 serv e-smith[1574]: Processing event: ip-change 195.121.129.249
14:11:58 serv e-smith[1574]: Running event handler: /etc/e-smith/events/ip-change/S15set-external-ip
14:11:59 serv /etc/e-smith/events/ip-change/S15set-external-ip[1575]: /home/e-smith/configuration: OLD ExternalIP=195.121.128.150
14:11:59 serv /etc/e-smith/events/ip-change/S15set-external-ip[1575]: /home/e-smith/configuration: NEW ExternalIP=195.121.129.249
14:11:59 serv e-smith[1574]: S15set-external-ip=action|Event|ip-change|Action|S15set-external-ip|Start|1017835918 518357|End|1017835919 503951|Elapsed|0.985594
14:11:59 serv e-smith[1574]: Running event handler: /etc/e-smith/events/ip-change/S16restart-masq
14:12:00 serv e-smith[1574]:
14:12:00 serv e-smith[1574]: Shutting down IP masquerade and firewall rules:^I^IDone!
14:12:00 serv e-smith[1574]:
14:12:01 serv atalkd[1458]: zip_getnetinfo for eth0
14:12:02 serv e-smith[1574]: Enabling IP masquerading: done
14:12:02 serv e-smith[1574]: S16restart-masq=action|Event|ip-change|Action|S16restart-masq|Start|1017835919 504528|End|1017835922 55157|Elapsed|2.550629
14:12:02 serv e-smith[1574]: Running event handler: /etc/e-smith/events/ip-change/S47proftpd-conf
14:12:02 serv login(pam_unix)[1527]: session opened for user admin by LOGIN(uid=0)
14:12:02 serv  -- admin[1527]: LOGIN ON tty1 BY admin
14:12:05 serv e-smith[1574]: S47proftpd-conf=action|Event|ip-change|Action|S47proftpd-conf|Start|1017835922 55702|End|1017835925 129082|Elapsed|3.07338
14:12:05 serv e-smith[1574]: Running event handler: /etc/e-smith/events/ip-change/S50conf-security
14:12:09 serv e-smith[1574]: S50conf-security=action|Event|ip-change|Action|S50conf-security|Start|1017835925 129606|End|1017835929 572205|Elapsed|4.442599
14:12:09 serv e-smith[1574]: Running event handler: /etc/e-smith/events/ip-change/S55conf-httpd
14:12:11 serv atalkd[1458]: config for no router
14:12:12 serv atalkd[1458]: ready 0/0/0
14:12:12 serv atalk: atalkd startup succeeded
14:12:14 serv e-smith[1574]: S55conf-httpd=action|Event|ip-change|Action|S55conf-httpd|Start|1017835929 572735|End|1017835934 108699|Elapsed|4.535964
14:12:14 serv e-smith[1574]: Running event handler: /etc/e-smith/events/ip-change/S75restart-httpd-full
14:12:14 serv e-smith[1574]: S75restart-httpd-full=action|Event|ip-change|Action|S75restart-httpd-full|Start|1017835934 109249|End|1017835934 873854|Elapsed|0.764605
14:12:14 serv e-smith[1574]: Running event handler: /etc/e-smith/events/ip-change/S80pptpd-conf
14:12:16 serv e-smith[1574]: S80pptpd-conf=action|Event|ip-change|Action|S80pptpd-conf|Start|1017835934 878132|End|1017835936 141205|Elapsed|1.263073
14:12:16 serv e-smith[1574]: Running event handler: /etc/e-smith/events/ip-change/S85update-dns
14:12:16 serv httpd-e-smith: httpd shutdown succeeded
14:12:16 serv e-smith-bg: Shutting down http: [   OK   ]^M
14:12:17 serv e-smith[1574]: S85update-dns=action|Event|ip-change|Action|S85update-dns|Start|1017835936 141736|End|1017835937 80654|Elapsed|0.938918
14:12:17 serv e-smith[1574]: Running event handler: /etc/e-smith/events/ip-change/S90pptpd-restart
14:12:17 serv e-smith[1574]: S90pptpd-restart=action|Event|ip-change|Action|S90pptpd-restart|Start|1017835937 84764|End|1017835937 366607|Elapsed|0.281843
14:12:17 serv e-smith[1574]: Running event handler: /etc/e-smith/events/ip-change/S90restart-ntpd
14:12:18 serv e-smith[1574]: S90restart-ntpd=action|Event|ip-change|Action|S90restart-ntpd|Start|1017835937 370731|End|1017835938 993839|Elapsed|1.623108
14:12:19 serv e-smith[1782]: Processing event: ip-up ippp0 /dev/ippp0 0 195.121.129.249 193.172.250.31 diald
14:12:19 serv e-smith[1782]: Running event handler: /etc/e-smith/events/ip-up/S20email-ipup
14:12:19 serv atalk:   Registering serv:Workstation: succeeded
14:12:21 serv e-smith[1782]: S20email-ipup=action|Event|ip-up|Action|S20email-ipup|Start|1017835939 409447|End|1017835941 80442|Elapsed|1.670995
14:12:21 serv e-smith[1782]: Running event handler: /etc/e-smith/events/ip-up/S55set-gateway-ip
14:12:22 serv ntpd: ntpd shutdown failed
14:12:23 serv e-smith-bg: Shutting down ntpd: [ FAILED ]^M
14:12:23 serv /etc/e-smith/events/ip-up/S55set-gateway-ip[1802]: /home/e-smith/configuration: OLD GatewayIP=193.172.250.153
14:12:23 serv /etc/e-smith/events/ip-up/S55set-gateway-ip[1802]: /home/e-smith/configuration: NEW GatewayIP=193.172.250.31
14:12:23 serv e-smith[1782]: S55set-gateway-ip=action|Event|ip-up|Action|S55set-gateway-ip|Start|1017835941 80996|End|1017835943 379462|Elapsed|2.298466
14:12:25 serv atalk:   Registering serv:netatalk: succeeded
14:12:25 serv atalk: papd startup succeeded
14:12:25 serv papd[1819]: restart (1.5pre7)
14:12:26 serv atalk: afpd startup succeeded
14:12:28 serv httpd-e-smith: httpd startup succeeded
14:12:28 serv e-smith-bg: Starting httpd: [   OK   ]^M
14:12:32 serv afpd[1824]: serv:AFPServer@* started on 65280.238:254 (1.5pre7)
14:12:32 serv afpd[1824]: ASIP started on 192.168.240.1:548(2) (1.5pre7)
14:12:32 serv afpd[1824]: uam : Loading (/etc/atalk/uams/uams_clrtxt.so)
14:12:32 serv afpd[1824]: uam: uams_clrtxt.so loaded
14:12:32 serv afpd[1824]: uam : Loading (/etc/atalk/uams/uams_dhx.so)
14:12:33 serv afpd[1824]: uam: uams_dhx.so loaded
14:12:33 serv afpd[1824]: uam : Loading (/etc/atalk/uams/uams_pgp.so)
14:12:33 serv afpd[1824]: uam: uams_pgp.so loaded
14:12:33 serv afpd[1824]: uam: "PGPuam 1.0" available
14:12:33 serv afpd[1824]: uam: "DHCAST128" available
14:12:33 serv afpd[1824]: uam: "Cleartxt Passwrd" available
14:12:34 serv diald[870]: Closing down idle link.
14:12:34 serv ipppd[838]: Modem hangup
14:12:34 serv ipppd[838]: Connection terminated.
14:12:34 serv ipppd[838]: taking down PHASE_DEAD link 0, linkunit: 0
14:12:34 serv ipppd[838]: sent
  • [LCP TermReq id=0x2 6c 69 6e 6b 20 63 6c 6f 73 65 64]

14:12:34 serv ipppd[838]: LCP is down
14:12:34 serv ipppd[838]: closing fd 7 from unit 0
14:12:34 serv ipppd[838]: link 0 closed , linkunit: 0
14:12:34 serv ipppd[838]: reinit_unit: 0
14:12:34 serv ipppd[838]: Connect[0]: /dev/ippp0, fd: 7
14:12:34 serv kernel: isdn_net: local hangup ippp0
14:12:34 serv kernel: ippp0: Chargesum is 0
14:12:34 serv diald[870]: disconnector: Link is down
14:12:34 serv kernel: ippp, open, slot: 2, minor: 0, state: 0000
14:12:34 serv kernel: ippp_ccp: allocated reset data structure c213b800
14:12:34 serv kernel: ippp_ccp: freeing reset data structure c3442000
14:12:34 serv kernel: isdn: HiSax,ch0 cause: E0010
14:12:34 serv diald[870]: Disconnected. Call duration 38 seconds.
14:12:34 serv diald[870]: IP transmitted 90 bytes and received 464 bytes.
14:12:34 serv diald[870]: Delaying 10 seconds before clear to dial.
14:12:35 serv e-smith[1865]: Processing event: ip-down ippp0 /dev/ippp0 0 195.121.129.249 193.172.250.31 diald
14:12:35 serv e-smith[1865]: Running event handler: /etc/e-smith/events/ip-down/S50isdn-down-notify
14:12:35 serv diald[870]: FIFO: link down request
14:12:35 serv e-smith[1865]: S50isdn-down-notify=action|Event|ip-down|Action|S50isdn-down-notify|Start|1017835955 121787|End|1017835955 843496|Elapsed|0.721709
14:13:04 serv e-smith[1877]: Processing event: email-update
14:13:04 serv e-smith[1877]: Running event handler: /etc/e-smith/events/email-update/S50conf-masq
14:13:06 serv e-smith[1877]: S50conf-masq=action|Event|email-update|Action|S50conf-masq|Start|1017835984 167218|End|1017835986 608812|Elapsed|2.441594
14:13:06 serv e-smith[1877]: Running event handler: /etc/e-smith/events/email-update/S50conf-php
14:13:07 serv e-smith[1877]: S50conf-php=action|Event|email-update|Action|S50conf-php|Start|1017835986 609397|End|1017835987 322285|Elapsed|0.712888
14:13:07 serv e-smith[1877]: Running event handler: /etc/e-smith/events/email-update/S50conf-security
14:13:09 serv e-smith[1877]: S50conf-security=action|Event|email-update|Action|S50conf-security|Start|1017835987 326417|End|1017835989 89177|Elapsed|1.76276
14:13:09 serv e-smith[1877]: Running event handler: /etc/e-smith/events/email-update/S55conf-horde
14:13:09 serv e-smith[1877]: S55conf-horde=action|Event|email-update|Action|S55conf-horde|Start|1017835989 89725|End|1017835989 803130|Elapsed|0.713405
14:13:09 serv e-smith[1877]: Running event handler: /etc/e-smith/events/email-update/S55conf-httpd
14:13:13 serv e-smith[1877]: S55conf-httpd=action|Event|email-update|Action|S55conf-httpd|Start|1017835989 807294|End|1017835993 780318|Elapsed|3.973024
14:13:13 serv e-smith[1877]: Running event handler: /etc/e-smith/events/email-update/S55email-conf
14:13:15 serv e-smith[1877]: S55email-conf=action|Event|email-update|Action|S55email-conf|Start|1017835993 780858|End|1017835995 488797|Elapsed|1.707939
14:13:15 serv e-smith[1877]: Running event handler: /etc/e-smith/events/email-update/S55obtuse-smtpd-conf
14:13:16 serv e-smith[1877]: S55obtuse-smtpd-conf=action|Event|email-update|Action|S55obtuse-smtpd-conf|Start|1017835995 489346|End|1017835996 664045|Elapsed|1.174699
14:13:16 serv e-smith[1877]: Running event handler: /etc/e-smith/events/email-update/S55pine-conf
14:13:17 serv e-smith[1877]: S55pine-conf=action|Event|email-update|Action|S55pine-conf|Start|1017835996 664598|End|1017835997 459991|Elapsed|0.795393
14:13:17 serv e-smith[1877]: Running event handler: /etc/e-smith/events/email-update/S60conf-imp
14:13:18 serv e-smith[1877]: S60conf-imp=action|Event|email-update|Action|S60conf-imp|Start|1017835997 464134|End|1017835998 318604|Elapsed|0.85447
14:13:18 serv e-smith[1877]: Running event handler: /etc/e-smith/events/email-update/S65conf-other
14:13:20 serv e-smith[1877]: S65conf-other=action|Event|email-update|Action|S65conf-other|Start|1017835998 322579|End|1017836000 67390|Elapsed|1.744811
14:13:20 serv e-smith[1877]: Running event handler: /etc/e-smith/events/email-update/S65restart-httpd-graceful
14:13:20 serv e-smith[1877]: S65restart-httpd-graceful=action|Event|email-update|Action|S65restart-httpd-graceful|Start|1017836000 67941|End|1017836000 788694|Elapsed|0.720753
14:13:20 serv e-smith[1877]: Running event handler: /etc/e-smith/events/email-update/S75obtuse-smtpd-restart
14:13:22 serv httpd-e-smith: httpd -USR1 succeeded
14:13:22 serv e-smith[1877]: S75obtuse-smtpd-restart=action|Event|email-update|Action|S75obtuse-smtpd-restart|Start|1017836000 792924|End|1017836002 375424|Elapsed|1.5825
14:13:22 serv e-smith[1877]: Running event handler: /etc/e-smith/events/email-update/S90email-sighup
14:13:22 serv e-smith[1877]: S90email-sighup=action|Event|email-update|Action|S90email-sighup|Start|1017836002 376000|End|1017836002 651284|Elapsed|0.275284
14:13:22 serv e-smith[1877]: Running event handler: /etc/e-smith/events/email-update/S90restart-masq
14:13:23 serv smtpfwdd: smtpfwdd shutdown succeeded

Peter

Re: Modem trouble ISDN
« Reply #1 on: April 17, 2002, 09:39:20 PM »
Hi
Not all ISDN internal Modems are the same, some work others well you can keep trying and the best of luck. If you want a stable  ISDN system you need an EX ternal modem we use Hayes Accura Terminal adapter with a serial connection using one of your Coms Ports. It will work out of the box.

kristallix

Re: Modem trouble ISDN
« Reply #2 on: April 18, 2002, 02:21:53 PM »
Peter,

I've tried an EXTERNAL modem, a DYNALINK IS128AE+ ISDN.

This modem was not even recognized by the 5.1.2 server  after a clean install. I don't care which modem does the job as long as i can get the job done. So...if you can tell me how to get this external modem working......

Thanks

Peter

Re: Modem trouble ISDN
« Reply #3 on: April 19, 2002, 04:44:11 AM »
Hi

Sorry I have never had any thing to do with DYNALINK IS128AE+ ISDN. devices. We have followed on from RedHat Linux and after testing a number of EX ISDN Boxs we found Hayes or 3Com to be the best. What I can say is that 5.1.2 will see these EX boxes, you just tell the manager which Coms port the box is on. ie Coms1 or Coms2. The only proble we have had is if the ISDN Box was made in another counrty you may have to flash the BIOS with software provided. We do this in Windows. Once the Box is set ot your countrys requirements, Linux Should see it.
Hope this helps.