MAILX.HPBIN.SYS SLOW (434 Views)
Reply
Trusted Contributor
Scott Hower
Posts: 127
Registered: ‎05-28-2001
Message 1 of 13 (434 Views)
Accepted Solution

MAILX.HPBIN.SYS SLOW

Jobs on my system (997-200 MPE/iX 6.5 PPIII) seem to take a long time when sending an email using MAILX.HPBIN.SYS. Nothing unusual appears in GLANCE - it just seems as though the system isn't giving time to this particular process. Is there a performance tune for this or perhaps a networking configuration change that could fix this?
Respected Contributor
Chris Bartram
Posts: 377
Registered: ‎01-03-2002
Message 2 of 13 (434 Views)

Re: MAILX.HPBIN.SYS SLOW

Most email slowness can be attributed to DNS issues. Slow lookups or timeouts. Since the process would be waiting on an external resource, it wouldn't get (or be waiting on) local system resources (CPU/etc).

Verify that DNS is setup on your system (if applicable). See RESLVCNF.NET.SYS.
If you're not using DNS, make sure that any hostnames you're emailing to are in the local NMMGR directory or are otherwise "known" to the system.

HTH,
Chris Bartram
Trusted Contributor
Scott Hower
Posts: 127
Registered: ‎05-28-2001
Message 3 of 13 (434 Views)

Re: MAILX.HPBIN.SYS SLOW

I'm going to bounce this one back to the top. I don't use RESLVCNF.NET.SYS - I renamed it last year while troubleshooting an FTP problem and didn't put it back after the problem was resolved and no new ones appeared. The mail sent from the e3000 shows the return address of the machine's node name - I don't think that it is in any way affected by my organization's Exchange server and therefore doesn't need to know its address. Thanks!
Respected Contributor
James Hofmeister
Posts: 134
Registered: ‎09-09-2003
Message 4 of 13 (434 Views)

Re: MAILX.HPBIN.SYS SLOW

Hello All,

I did a quick test on a bit smaller machine, a 987-200 running 6.5 and found that MAILX sent a 1 line message in an average of 7 seconds for 10 passes. Is your performance better or worst than this ?

Regards,
James Hofmeister
Our customers are 1st with Speed, Power and Passion!
Trusted Contributor
Scott Hower
Posts: 127
Registered: ‎05-28-2001
Message 5 of 13 (434 Views)

Re: MAILX.HPBIN.SYS SLOW

Much much worse. I would estimate that the process often takes two to five minutes.
Respected Contributor
James Hofmeister
Posts: 134
Registered: ‎09-09-2003
Message 6 of 13 (434 Views)

Re: MAILX.HPBIN.SYS SLOW

Hello All,

Is this poor performance seen while the system is under load or idle ? Also, what kind of performance do you see when you enter the POSIX shell ?

: xeq sh.hpbin.sys;info="-L"

Regards,
James Hofmeister
Our customers are 1st with Speed, Power and Passion!
Trusted Contributor
Scott Hower
Posts: 127
Registered: ‎05-28-2001
Message 7 of 13 (434 Views)

Re: MAILX.HPBIN.SYS SLOW

System load doesn't seem to have an effect. There is a slight delay when entering the Posix shell from an MPE prompt but it is only a few seconds. Commands in Posix seem nearly instantaneous.
Respected Contributor
James Hofmeister
Posts: 134
Registered: ‎09-09-2003
Message 8 of 13 (434 Views)

Re: MAILX.HPBIN.SYS SLOW

Hello All,

In this case it would be good to get a stack trace of the MAILX.HPBIN.SYS process... This is probably easiest in glance, start the mailx, then in glance "p" for pin, enter the pin as displayed in glance and then select "display trace". The more complicated way is to use debug... start the mailx, then in :debug >:showproc ;job=#s/j####;system;tree. With the pin identified as MAILX.HPBIN.SYS, enter #pin at the debug prompt, next perform a trace "tr,d,i" and finally exit.

If you cut/past a stack trace to this message thread we can probably determine more of what is happening.

Regards,
James Hofmeister
Our customers are 1st with Speed, Power and Passion!
Trusted Contributor
Scott Hower
Posts: 127
Registered: ‎05-28-2001
Message 9 of 13 (434 Views)

Re: MAILX.HPBIN.SYS SLOW

Just a simple showproc and listf of SENDMAIL.PUB.SENDMAIL:

:SHOWPROC JOB=#S4617
QPRI CPUTIME STATE JOBNUM PIN (PROGRAM) STEP

C152 0:14.376 WAIT S4617 860 :RUN MAILX.HPBIN.SYS;INFO="-s 'MAILX Test'$
C155 0:00.225 WAIT S4617 759 (MAILX.HPBIN.SYS) -s 'MAILX Test' scott.$
C152 0:00.278 WAIT S4617 1076 (SH.HPBIN.SYS)
C152 0:00.150 WAIT S4617 1143 (SENDMAIL.PUB.SENDMAIL)
:LISTF SENDMAIL.PUB.SENDMAIL,-3
********************
FILE: SENDMAIL.PUB.SENDMAIL

FILE CODE : 1030 FOPTIONS: BINARY,FIXED,NOCCTL,STD
BLK FACTOR: 1 CREATOR : SERVER.SENDMAIL
REC SIZE: 256(BYTES) LOCKWORD:
BLK SIZE: 256(BYTES) SECURITY--READ : ANY
EXT SIZE: 0(SECT) WRITE : ANY
NUM REC: 3771 APPEND : ANY
NUM SEC: 3776 LOCK : ANY
NUM EXT: 1 EXECUTE : ANY
MAX REC: 3771 **SECURITY IS ON
FLAGS : 1 ACCESSOR,SHARED,1 R
NUM LABELS: 0 CREATED : WED, MAR 3, 1999, 1:22 PM
MAX LABELS: 0 MODIFIED: TUE, JUL 21, 1998, 5:17 PM
DISC DEV #: 2 ACCESSED: WED, MAY 5, 2004, 6:27 AM
SEC OFFSET: 0 LABEL ADDR: $0000009C.$00365720
VOLCLASS : MPEXL_SYSTEM_VOLUME_SET:DISC


:


And the GLANCE trace:

HPB1787 B.10.13 HP GlancePlus/iX 10:40:38 Process (Pin 987 - #S4617)
+ 0: 0:31 current avg high
CPU M MSSI I* BP P.............| 28% 17% 28%
Disc M MSI * IB B....................| 127 37 127
Mem M MCS SD DF F*| 98% 98% 99%
Process Selection Summary
CPU *..............................< 0.0% | NMPRG /SENDMAIL/PUB/SENDMAIL
Disc *..............................< 0.0 | Elapsed | CPU-Tot | Disc-Tot
WorkGroup:CS_Default N | 4.7 min | 0.3 sec | 2
State F FO<100%
Last F FO<100%
Wait : MESSAGE 100% | Compatibility Mode % ..............< 5%
Queue/Priority : C152 | Native Mode Switches ..............< 0/sec
Scheduling State : Long Wait | Comp. Mode Switches ..............< 0/sec
Transactions/min : 0 | Response Time ..............< 0.00


XPERT:|MEMORY DEMAND IS HIGH|

Procedure Trace for Pin 987 is:

PC=a.0018399c enable_int+$2c
NM* 0) SP=4184a890 RP=a.00799004 notify_dispatcher.block_current_process+$338
NM 1) SP=4184a890 RP=a.0079ae44 notify_dispatcher+$268
NM 2) SP=4184a810 RP=a.001caa64 wait_for_active_port+$e8
NM 3) SP=4184a710 RP=a.001cb6c8 receive_from_port+$544
NM 4) SP=4184a690 RP=a.015b1838 selective_receive+$3ec
NM 5) SP=4184a490 RP=a.00737014 hpselect_nm+$254
NM 6) SP=4184a350 RP=a.00736d8c ?hpselect_nm+$8
export stub: a.002d78c0 HPSELECT+$1054
NM 7) SP=41849fd0 RP=a.002d6858 ?HPSELECT+$8
export stub: 67c.0009648c
NM 8) SP=41849a50 RP=67c.0008547c
NM 9) SP=41849850 RP=67c.00082d50
NM a) SP=41849590 RP=67c.0008f198
NM b) SP=41849110 RP=67c.0008efcc
export stub: 67c.0008a1b8
NM c) SP=41848890 RP=67c.0008a11c
export stub: 67c.000837f4
NM d) SP=41848810 RP=67c.0003cef4
NM e) SP=41848790 RP=67c.0003d20c
NM f) SP=41848750 RP=67c.0004ed90
NM 10) SP=41848590 RP=67c.0009d00c
NM 11) SP=41846e10 RP=67c.00036bb4
NM 12) SP=41845c90 RP=67c.00000000
(end of NM stack)


Press RETURN to continue (or enter a GLANCE command):


Open files:

Open Files for Process 898 are:

File Group Account Type Rec-Ptr EOF Domain Access Share Opens
MAILX .HPBIN .SYS NMPRG 0 1068 PERM LOAD M SEM 3
/etc/mailx.rc 860 860 PERM IN SHR 3
? 0
SH .HPBIN .SYS NMPRG 0 1691 PERM LOAD M SEM 2
SENDMAIL.PUB .SENDMAIL NMPRG 0 3771 PERM LOAD M SEM 1

Press RETURN to continue (or enter a GLANCE command):
Respected Contributor
James Hofmeister
Posts: 134
Registered: ‎09-09-2003
Message 10 of 13 (434 Views)

Re: MAILX.HPBIN.SYS SLOW

Hello Scott,

Actually the process we want to see a stack trace of is:

C155 0:00.225 WAIT S4617 759 (MAILX.HPBIN.SYS) -s 'MAILX Test' scott.$

Regards,
James Hofmeister
Our customers are 1st with Speed, Power and Passion!
Trusted Contributor
Scott Hower
Posts: 127
Registered: ‎05-28-2001
Message 11 of 13 (436 Views)

Re: MAILX.HPBIN.SYS SLOW

:SHOWPROC JOB=#S4617
QPRI CPUTIME STATE JOBNUM PIN (PROGRAM) STEP

C152 0:14.742 WAIT S4617 860 :RUN MAILX.HPBIN.SYS;INFO="-s 'MAILX Test'$
C163 0:00.218 WAIT S4617 1028 (MAILX.HPBIN.SYS) -s 'MAILX Test' scott.$
C152 0:00.277 WAIT S4617 821 (SH.HPBIN.SYS)
C152 0:00.159 WAIT S4617 708 (SENDMAIL.PUB.SENDMAIL)
:




HPB1787 B.10.13 HP GlancePlus/iX 11:06:47 Process (Pin 1028 - #S4617)
+ 0: 0: 4 current avg high
CPU M MI IBBP * P| 68% 73% 77%
Disc SIB *...............................| 85 86 88
Mem M MCS SD DF *| 99% 99% 99%
Process Selection Summary
CPU *..............................< 0.0% | NMPRG MAILX.HPBIN.SYS
Disc *..............................< 0.0 | Elapsed | CPU-Tot | Disc-Tot
WorkGroup:CS_Default N | 2.2 min | 0.3 sec | 0
State F FO O<100%
Last F F<100%
Wait : CHILD PROCESS | Compatibility Mode % ..............< 0%
Queue/Priority : C163 | Native Mode Switches ..............< 0/sec
Scheduling State : Long Wait | Comp. Mode Switches ..............< 0/sec
Transactions/min : 0 | Response Time ..............< 0.00



Initial call to HP Debug will require a 5 to 30 second delay, please wait...

Procedure Trace for Pin 1028 is:

PC=a.0018399c enable_int+$2c
NM* 0) SP=418440b0 RP=a.00799004 notify_dispatcher.block_current_process+$338
NM 1) SP=418440b0 RP=a.0079ae44 notify_dispatcher+$268
NM 2) SP=41844030 RP=a.001caa64 wait_for_active_port+$e8
NM 3) SP=41843f30 RP=a.001cb6c8 receive_from_port+$544
NM 4) SP=41843eb0 RP=a.0076f5e4 extend_receive+$494
NM 5) SP=41843cb0 RP=a.0076f11c ?extend_receive+$8
export stub: a.009c787c px_await_signal+$cc
NM 6) SP=41843b70 RP=a.002b29b4 px_waitpid+$940
NM 7) SP=41843a30 RP=a.002b2060 ?px_waitpid+$8
export stub: 10b.00a70c44 _px_waitpid+$20
NM 8) SP=418437b0 RP=10b.00a70c10 ?_px_waitpid+$8
export stub: 83a.0002d108
NM 9) SP=41843730 RP=83a.0001e8e0
NM a) SP=418436f0 RP=83a.00013eac
NM b) SP=41843670 RP=83a.00013c4c
NM c) SP=418435f0 RP=83a.00013a18
NM d) SP=41843570 RP=83a.0001278c
NM e) SP=41843530 RP=83a.000216d4
NM f) SP=41843430 RP=83a.00027664
NM 10) SP=41843330 RP=83a.000122cc
NM 11) SP=418421b0 RP=83a.00000000
(end of NM stack)


Press RETURN to continue (or enter a GLANCE command):




Open Files for Process 1028 are:

File Group Account Type Rec-Ptr EOF Domain Access Share Opens
MAILX .HPBIN .SYS NMPRG 0 1068 PERM LOAD M SEM 3
/etc/mailx.rc 860 860 PERM IN SHR 3
/tmp/malx013F0404.aaa 5 5 PERM I/O SHR 2

Press RETURN to continue (or enter a GLANCE command):




Process Family for Pin 1028 is:

Parent is Pin 860 executing program CI.PUB.SYS

Child Processes are:
Pin 821 executing program SH.HPBIN.SYS
Pin 708 executing program SENDMAIL.PUB.SENDMAIL



Press RETURN to continue (or enter a GLANCE command):
Respected Contributor
James Hofmeister
Posts: 134
Registered: ‎09-09-2003
Message 12 of 13 (436 Views)

Re: MAILX.HPBIN.SYS SLOW

Hello Scott,

The MAILX is waiting on a signal in code px_await_signal+$cc. I am suspect of a code problem between the SH.HPBIN.SYS and MAILX associated with signaling.

This is not a known problem as I have been able to see from any of our solutions databases.

At this point I think it would be best to place a call to the HP-RC and mail them the stack trace of MAILX.HPBIN.SYS and SH.HPBIN.SYS as a starting point for the investigation.

Regards,
James Hofmeister
Our customers are 1st with Speed, Power and Passion!
Trusted Contributor
Scott Hower
Posts: 127
Registered: ‎05-28-2001
Message 13 of 13 (436 Views)

Re: MAILX.HPBIN.SYS SLOW

All,

Thanks for your pointers. I initiated a software call...the issue was, in fact, related to the RESLVCNF.NET.SYS file (I renamed it several months ago while troubleshooting an FTP issue). I renamed the file back to RESLVCNF and cut the time that it took to send an email from several minutes to fractions of a second. Chris was right in the very first response. Thanks again!!

The elapsed time of sending an email without a RESLVCNF.NET.SYS file:
HPHHMMSSMMM = 134548300
HPHHMMSSMMM = 135054700

The elapsed time of sending an email with a RESLVCNF.NET.SYS file:
HPHHMMSSMMM = 150424300
HPHHMMSSMMM = 150426400
The opinions expressed above are the personal opinions of the authors, not of HP. By using this site, you accept the Terms of Use and Rules of Participation.