Working with a slight problem :-) -----Original Message----- From: Action Request System discussion list(ARSList) [mailto:[EMAIL PROTECTED] Behalf Of Jarl Grøneng Sent: Tuesday, July 10, 2007 9:03 AM To: arslist@ARSLIST.ORG Subject: Re: ARS7 install with oracle 10G RAC ... the saga continues ...
** Do you really think you will get an answer other than "as designed"? :-) -- Jarl Yuppi yeee, got an ok to travel to Vancouver in october :-) On 7/10/07, Tony Worthington <[EMAIL PROTECTED]> wrote: > Yup. And the second query (each taking about four minutes on our boxes) > is: > > SELECT schemaId,fieldId,groupId,permission FROM field_permissions ORDER BY > 1 ASC,2 ASC,3 ASC > > I wonder if we could get a defect filed, and have this looked at by > engineering... and get an answer more than "as designed." > > -tony > > -- > Tony Worthington > [EMAIL PROTECTED] > 262-703-5911 > > > > Axton < [EMAIL PROTECTED]> > Sent by: "Action Request System discussion list(ARSList)" > <arslist@ARSLIST.ORG> > 07/09/2007 05:55 PM > Please respond to > arslist@ARSLIST.ORG > > > To > arslist@ARSLIST.ORG > cc > > Subject > Re: ARS7 install with oracle 10G RAC ... the saga continues ... > > > > > > > Remedy fetches information from it's data dictionary (e.g., > field_disp_prop, field, etc.), then processes it in chunks of 100, > 500, or 1000. So if you have a table field_dispprop that has 120k > records and 500 records are processed at a time, 15 seconds per chunk, > you end up with a start time that totals 3600 seconds (for that part > of the startup). > > If you add a -t parameter to arserverd in the armonitor.conf file, a > special startup log file is created. The log file will look something > like this: > > Jul 09 2007 18:29:06.6577 <Startup> <TID:3086968512> Set up thread > control block with key = 0 > Jul 09 2007 18:29:06.6582 <Startup> <TID:3086968512> Initialize thread > local storage block > Jul 09 2007 18:29:06.6583 <Startup> <TID:3086968512> Initialize > mutiple-byte environment > Jul 09 2007 18:29:06.6585 <Startup> <TID:3086968512> InstallDir = > /u01/arsystem/arsdev > Jul 09 2007 18:29:06.6587 <Startup> <TID:3086968512> Initialize Server > utility > Jul 09 2007 18:29:06.6599 <Startup> <TID:3086968512> Initialize License > Library > Jul 09 2007 18:29:06.6602 <Startup> <TID:3086968512> LicenseFilename = > /etc/arsystem/arsdev/arsystem.lic > Jul 09 2007 18:29:06.6603 <Startup> <TID:3086968512> Initialize > Language setting and locale > Jul 09 2007 18:29:06.6610 <Startup> <TID:3086968512> Initialize the > Decimal Math libray > Jul 09 2007 18:29:06.6610 <Startup> <TID:3086968512> Open shared catalog > Jul 09 2007 18:29:06.6648 <Startup> <TID:3086968512> Load encryption > shared library > Jul 09 2007 18:29: 06.6653 <Startup> <TID:3086968512> Load encryption > static functions > Jul 09 2007 18:29:06.6654 <Startup> <TID:3086968512> Initialize > default configuration information > Jul 09 2007 18:29: 06.6654 <Startup> <TID:3086968512> Create Mutexes > Jul 09 2007 18:29:06.6655 <Startup> <TID:3086968512> Initialize parse > environment > Jul 09 2007 18:29:06.6657 <Startup> <TID:3086968512> Initialize date > time information > Jul 09 2007 18:29:06.6659 <Startup> <TID:3086968512> Initialize > notification strings > Jul 09 2007 18:29:06.6659 <Startup> <TID:3086968512> Initialize RPC > queue type strings > Jul 09 2007 18:29:06.6660 <Startup> <TID:3086968512> Initialize filter > strings > Jul 09 2007 18:29:06.6662 <Startup> <TID:3086968512> Initialize > escalation strings > Jul 09 2007 18:29:06.6662 <Startup> <TID:3086968512> Load system > configuration file > Jul 09 2007 18:29:06.6669 <Startup> <TID:3086968512> > arsCodeSet=windows-1252[0] arDbCodeSet=windows-1252[0] > Jul 09 2007 18:29:06.6670 <Startup> <TID:3086968512> Initialize pending > lists > Jul 09 2007 18:29:06.6671 <Startup> <TID:3086968512> Create cache read > write lock > Jul 09 2007 18:29: 06.6671 <Startup> <TID:3086968512> Create full text > status read write lock > Jul 09 2007 18:29:06.6672 <Startup> <TID:3086968512> Initialize fork proxy > Jul 09 2007 18:29:06.6672 <Startup> <TID:3086968512> Check licensing > Jul 09 2007 18:29:06.6693 <Startup> <TID:3086968512> Initialize user cache > Jul 09 2007 18:29:06.6707 <Startup> <TID:3086968512> Open log file > Jul 09 2007 18:29:06.6745 <Startup> <TID:3086968512> Initialize XML parser > Jul 09 2007 18:29:06.6782 <Startup> <TID:3086968512> Initialize thread > list > Jul 09 2007 18:29: 06.6784 <Startup> <TID:3086968512> Check multiple > servers > Jul 09 2007 18:29:06.6787 <Startup> <TID:3086968512> Initialize dead > thread list > Jul 09 2007 18:29:06.6790 <Startup> <TID:3086968512> Initialize timed > calls > Jul 09 2007 18:29:06.6792 <Startup> <TID:3086968512> > CreateRPCQueue(min=1, max=1, rpc=390600) > Jul 09 2007 18:29:06.6793 <Startup> <TID:3086968512> Await cache ready... > Jul 09 2007 18:29:06.8988 <Startup> <TID:0030571424> > InitializeServerCache: LoadInitialSchemaInfo Begin > Jul 09 2007 18:29:11.7241 <Startup> <TID:0030571424> Begin > LoadDisplayInfoList > Jul 09 2007 18:29:25.6076 <Startup> <TID:0030571424> > LoadDisplayInfoList: 500 rows > Jul 09 2007 18:29:42.7008 <Startup> <TID:0030571424> > LoadDisplayInfoList: 1000 rows > > If you then review the sql that is sent to the db while the server is > unavailable, you will see this statement, followed by silence: > > SELECT schemaId,fieldId,vuiId,propShort,propLong FROM field_dispprop > ORDER BY 1 ASC, 2 ASC, 3 ASC > > What is happening here is that arserverd fetches the field display > property info, then processes it 500 records at a time. Depending on > the size of your server (number of forms, views, fields, etc), there > may be a couple of sql statements that are followed by a pause. > > What is happening internally is anyone's guess; I would guess that > they are processing X rows at a time to operate within certain memory > constraints, and 'maybe' in a horribly inefficient way. Some things > are for certain though; > (1) a lot of data is transferred from the db to the arserver. My test > server, which has 3293 rows in field_dispprop (pretty much a base > arserver install) sends 411K of data over the wire. > (2) the field_dispprop data is processed in chunks of 500 (at least on > Linux). > > Axton Grams > > > On 7/9/07, Andrew Hicox < [EMAIL PROTECTED]> wrote: > > ** > > Hello everyone: > > > > I've managed to get through the (incredibly flawed) solaris 10 arsystem > 7 > > install. > > This is 7.0.01 patch 2. > > > > I'm using oracle 10G client library with a remote database on an oracle > 10 > > Rapid Application Cluster. > > > > So ... now the server is INCREDIBLY slow to start. > > > > The server is configured to run on a TCP port (10000). > > When I issue the 'arsystem start' command, I get the usual output on the > > console indicating that the server has started. > > > > However, the TCP port is not listening, and of course, no clients can > > connect to the server. > > > > > > If I wait (approx 7 minutes), I will see the following output on the > > console: > > > > (ARNOTE 0) > > Server indicates that it's up. > > > > (ARNOTE 0) > > ARMonitor child process (pid:29595) started. > > ./arplugin > > > > Action Request System(R) Fork Daemon Version 7.0.01 patch 002 > > 200704021644 > > Copyright (c) 2000 - 2006 BMC Software, Inc. > > All rights reserved. > > > > Action Request System(R) Plug-In Server Version 7.0.01 patch 002 > > 200704021644 > > Copyright (c) 2001 - 2006 BMC Software, Inc. > > All rights reserved. > > Loaded Web Services plugin properly > > > > After the above, the TCP port opens up and clients can connect, and it > seems > > to work well enough. > > > > What I presume is happening here is that arserverd must issue some sort > of > > indication that it's completed start up so that arforkd and armonitor > can do > > their thing and start listeners and plugins, and that arserverd is for > some > > reason taking on average 7 minutes to do that. > > > > I can't manage to get ANY sort of logging during the 7 minutes of > mystery. > > is there some way to figgure out what the heck is going on durring this > > period of time (is it timing out DNS? is the db slow to respond? is it > > waiting on disk access? what is it doing?). > > > > We have an identical set up in our dev lab, with the exception that the > > database server is not a RAC and it's installed on the same machine. The > > startup is quite snappy on that setup. > > > > There don't appear to be any issues with network latency between the > remedy > > server and the RAC. > > > > Anyone ever seen this before? > > Any suggestions? > > > > thanks, > > > > Andrew > > ____________________________________________________________________________ ___ > UNSUBSCRIBE or access ARSlist Archives at www.arslist.org ARSlist:"Where > the Answers Are" > > > > CONFIDENTIALITY NOTICE: > This is a transmission from Kohl's Department Stores, Inc. > and may contain information which is confidential and proprietary. > If you are not the addressee, any disclosure, copying or distribution or use of the contents of this message is expressly prohibited. > If you have received this transmission in error, please destroy it and notify us immediately at 262-703-7000. > > CAUTION: > Internet and e-mail communications are Kohl's property and Kohl's reserves the right to retrieve and read any message created, sent and received. Kohl's reserves the right to monitor messages to or from authorized Kohl's Associates at any time > without any further consent. > > ____________________________________________________________________________ ___ > UNSUBSCRIBE or access ARSlist Archives at www.arslist.org ARSlist:"Where the Answers Are" > __20060125_______________________This posting was submitted with HTML in it___ No virus found in this outgoing message. Checked by AVG Free Edition. Version: 7.5.476 / Virus Database: 269.10.2/893 - Release Date: 7/9/2007 5:22 PM _______________________________________________________________________________ UNSUBSCRIBE or access ARSlist Archives at www.arslist.org ARSlist:"Where the Answers Are"
