Text only | Text with Images

NetXMS Support Forum

English Support => General Support => Topic started by: clifford on July 09, 2019, 09:23:01 AM

Title: Netxms Service not starting
Post by: clifford on July 09, 2019, 09:23:01 AM
Hi ,

Our Netxms Server service not starting. Below are the logs, please help.

[root@localhost ~]# tail -f /var/log/netxmsd
2019.07.09 11:48:16.897 *W* Failed to execute transformation script for object 2721340 "FIVE GARDEN" DCI 6410 ".1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67470094": Error 4 in line 1: Bad arithmetic conversion
2019.07.09 11:48:16.925 *W* Failed to execute transformation script for object 2721340 "FIVE GARDEN" DCI 6413 ".1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67470286": Error 4 in line 1: Bad arithmetic conversion
2019.07.09 11:48:16.926 *W* Failed to execute transformation script for object 2721340 "FIVE GARDEN" DCI 6414 ".1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67470350": Error 4 in line 1: Bad arithmetic conversion
2019.07.09 11:48:16.929 *W* Failed to execute transformation script for object 2721340 "FIVE GARDEN" DCI 6415 ".1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67470414": Error 4 in line 1: Bad arithmetic conversion
2019.07.09 11:48:16.931 *W* Failed to execute transformation script for object 2721340 "FIVE GARDEN" DCI 6416 ".1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67470478": Error 4 in line 1: Bad arithmetic conversion
2019.07.09 11:48:16.932 *W* Failed to execute transformation script for object 2721340 "FIVE GARDEN" DCI 6417 ".1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67470542": Error 4 in line 1: Bad arithmetic conversion
2019.07.09 11:48:16.936 *W* Failed to execute transformation script for object 2721340 "FIVE GARDEN" DCI 6418 ".1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67470606": Error 4 in line 1: Bad arithmetic conversion
2019.07.09 11:48:16.959 *W* Failed to execute transformation script for object 2721340 "FIVE GARDEN" DCI 6421 ".1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67470798": Error 4 in line 1: Bad arithmetic conversion
2019.07.09 11:48:16.960 *W* Failed to execute transformation script for object 2721340 "FIVE GARDEN" DCI 6422 ".1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67470862": Error 4 in line 1: Bad arithmetic conversion
2019.07.09 11:48:17.065 *W* Failed to execute transformation script for object 2721343 "THERGAON" DCI 5404 ".1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67470542": Error 4 in line 1: Bad arithmetic conversion


Thank you
Chandan
Title: Re: Netxms Service not starting
Post by: Victor Kirhenshtein on July 09, 2019, 01:08:56 PM
Hi,

those errors should not cause service to not start. Please try to run netxmsd from shell with -D9 option and post last lines of output.

Best regards,
Victor
Title: Re: Netxms Service not starting
Post by: clifford on July 22, 2019, 10:26:07 AM
Hi Victor,


We have executed netxmsd with D9 below is the out.

pollCount=4 requiredPolls=6
2019.07.22 12:53:58.438 *D* StatusPoll(Singapore_5850): polling interface 2704463 [10GE1/0/22]
2019.07.22 12:53:58.443 *D* Node(PADGHE)->GetItemFromSNMP(.1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67469838): dwResult=0
2019.07.22 12:53:58.443 *D* DataCollector(): processing DC object 4280 ".1.3.6.1.2.1.31.1.1.1.10.27" owner=2694021 sourceNode=0
2019.07.22 12:53:58.443 *D* [db.query           ] Successful sync query: "INSERT INTO idata_2693861 (item_id,idata_timestamp,idata_value) VALUES (3919,1563780238,'-23')" [0 ms]
2019.07.22 12:53:58.444 *D* Node(PADGHE)->GetItemFromSNMP(.1.3.6.1.2.1.1.3.0): dwResult=0
2019.07.22 12:53:58.445 *D* Node(MIRCHOLI)->GetItemFromSNMP(.1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67469710): dwResult=0
2019.07.22 12:53:58.445 *D* DataCollector(): processing DC object 4442 ".1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67470670" owner=2694021 sourceNode=0
2019.07.22 12:53:58.445 *D* [db.query           ] Successful sync query: "INSERT INTO idata_2693863 (item_id,idata_timestamp,idata_value) VALUES (3928,1563780238,'-17')" [0 ms]
2019.07.22 12:53:58.449 *D* Node(PADGHE)->GetItemFromSNMP(.1.3.6.1.4.1.2011.5.25.31.1.1.1.1.11.67108873): dwResult=0
2019.07.22 12:53:58.449 *D* DataCollector(): processing DC object 4443 ".1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67470862" owner=2694021 sourceNode=0
2019.07.22 12:53:58.450 *D* [db.query           ] Successful sync query: "INSERT INTO idata_2693861 (item_id,idata_timestamp,idata_value) VALUES (6704,1563780238,'38')" [0 ms]
2019.07.22 12:53:58.450 *D* DataCollector(): processing DC object 4459 ".1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67470414" owner=2694021 sourceNode=0
2019.07.22 12:53:58.450 *D* [db.query           ] Successful sync query: "INSERT INTO idata_2693861 (item_id,idata_timestamp,idata_value) VALUES (6703,1563780238,'144 days, 19:04')" [0 ms]
2019.07.22 12:53:58.456 *D* Node(MIRCHOLI)->GetItemFromSNMP(.1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67469838): dwResult=0
2019.07.22 12:53:58.456 *D* DataCollector(): processing DC object 5417 ".1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67469390" owner=2694021 sourceNode=0
2019.07.22 12:53:58.456 *D* [db.query           ] Successful sync query: "INSERT INTO idata_2693863 (item_id,idata_timestamp,idata_value) VALUES (3929,1563780238,'-15')" [0 ms]
2019.07.22 12:53:58.456 *D* Node(MIRCHOLI)->GetItemFromSNMP(.1.3.6.1.2.1.1.3.0): dwResult=0
2019.07.22 12:53:58.463 *D* Node(MIRCHOLI)->GetItemFromSNMP(.1.3.6.1.4.1.2011.5.25.31.1.1.1.1.11.67108873): dwResult=0
2019.07.22 12:53:58.463 *D* DataCollector(): processing DC object 5418 ".1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67469454" owner=2694021 sourceNode=0
2019.07.22 12:53:58.463 *D* [db.query           ] Successful sync query: "INSERT INTO idata_2693863 (item_id,idata_timestamp,idata_value) VALUES (6708,1563780238,'43')" [0 ms]
2019.07.22 12:53:58.464 *D* DataCollector(): processing DC object 5423 ".1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67469774" owner=2694021 sourceNode=0
2019.07.22 12:53:58.464 *D* [db.query           ] Successful sync query: "INSERT INTO idata_2693863 (item_id,idata_timestamp,idata_value) VALUES (6707,1563780238,'148 days, 19:36')" [0 ms]
2019.07.22 12:53:58.467 *D* Node(CHAKAN)->GetItemFromSNMP(.1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67470094): dwResult=0
2019.07.22 12:53:58.467 *D* DataCollector(): processing DC object 5425 ".1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67469902" owner=2694021 sourceNode=0
2019.07.22 12:53:58.467 *D* [db.query           ] Successful sync query: "INSERT INTO idata_2694021 (item_id,idata_timestamp,idata_value) VALUES (3951,1563780238,'-6')" [0 ms]
2019.07.22 12:53:58.482 *D* Node(CHAKAN)->GetItemFromSNMP(.1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67470158): dwResult=0
2019.07.22 12:53:58.482 *D* DataCollector(): processing DC object 5426 ".1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67469966" owner=2694021 sourceNode=0
2019.07.22 12:53:58.482 *D* [db.query           ] Successful sync query: "INSERT INTO idata_2694021 (item_id,idata_timestamp,idata_value) VALUES (3952,1563780238,'-8')" [0 ms]
2019.07.22 12:53:58.493 *D* Node(CHAKAN)->GetItemFromSNMP(.1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67470222): dwResult=0
2019.07.22 12:53:58.493 *D* [db.query           ] Successful sync query: "INSERT INTO idata_2694021 (item_id,idata_timestamp,idata_value) VALUES (3953,1563780238,'-7')" [0 ms]
2019.07.22 12:53:58.503 *D* Node(CHAKAN)->GetItemFromSNMP(.1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67470350): dwResult=0
2019.07.22 12:53:58.504 *D* [db.query           ] Successful sync query: "INSERT INTO idata_2694021 (item_id,idata_timestamp,idata_value) VALUES (3954,1563780238,'-6')" [0 ms]
2019.07.22 12:53:58.514 *D* Node(CHAKAN)->GetItemFromSNMP(.1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67469518): dwResult=0
2019.07.22 12:53:58.514 *D* [db.query           ] Successful sync query: "INSERT INTO idata_2694021 (item_id,idata_timestamp,idata_value) VALUES (3955,1563780238,'-16')" [0 ms]
2019.07.22 12:53:58.525 *D* Node(CHAKAN)->GetItemFromSNMP(.1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67469582): dwResult=0
2019.07.22 12:53:58.525 *D* [db.query           ] Successful sync query: "INSERT INTO idata_2694021 (item_id,idata_timestamp,idata_value) VALUES (3956,1563780238,'-19')" [0 ms]
2019.07.22 12:53:58.536 *D* Node(CHAKAN)->GetItemFromSNMP(.1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67469646): dwResult=0
2019.07.22 12:53:58.536 *D* [db.query           ] Successful sync query: "INSERT INTO idata_2694021 (item_id,idata_timestamp,idata_value) VALUES (3957,1563780238,'-18')" [0 ms]
2019.07.22 12:53:58.548 *D* Node(CHAKAN)->GetItemFromSNMP(.1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67469710): dwResult=0
2019.07.22 12:53:58.549 *D* [db.query           ] Successful sync query: "INSERT INTO idata_2694021 (item_id,idata_timestamp,idata_value) VALUES (3958,1563780238,'-17')" [0 ms]
2019.07.22 12:53:58.551 *D* Interface::StatusPoll(2704463,10GE1/0/22): new state from SNMP: adminState=1 operState=2
2019.07.22 12:53:58.551 *D* Interface::StatusPoll(2704463,10GE1/0/22): newStatus=0 oldStatus=0 pollCount=4 requiredPolls=6
2019.07.22 12:53:58.551 *D* StatusPoll(Singapore_5850): polling interface 2704464 [10GE1/0/23 (Stack-Port1/1)]
2019.07.22 12:53:58.551 *D* Node(TURBHE)->GetItemFromSNMP(.1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67470670): dwResult=0
2019.07.22 12:53:58.552 *D* [db.query           ] Successful sync query: "INSERT INTO idata_2693009 (item_id,idata_timestamp,idata_value) VALUES (5526,1563780238,'-8')" [1 ms]
2019.07.22 12:53:58.570 *D* Node(CHAKAN)->GetItemFromSNMP(.1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67469838): dwResult=0
2019.07.22 12:53:58.570 *D* [db.query           ] Successful sync query: "INSERT INTO idata_2694021 (item_id,idata_timestamp,idata_value) VALUES (3959,1563780238,'-19')" [0 ms]
2019.07.22 12:53:58.572 *D* Node(CHAKAN)->GetItemFromSNMP(.1.3.6.1.2.1.31.1.1.1.6.27): dwResult=0
2019.07.22 12:53:58.572 *D* [db.query           ] Successful sync query: "INSERT INTO idata_2694021 (item_id,idata_timestamp,idata_value) VALUES (4279,1563780238,'132496')" [0 ms]
2019.07.22 12:53:58.573 *D* Node(CHAKAN)->GetItemFromSNMP(.1.3.6.1.2.1.31.1.1.1.10.27): dwResult=0
2019.07.22 12:53:58.573 *D* [db.query           ] Successful sync query: "INSERT INTO idata_2694021 (item_id,idata_timestamp,idata_value) VALUES (4280,1563780238,'1923560')" [0 ms]
2019.07.22 12:53:58.583 *D* Node(CHAKAN)->GetItemFromSNMP(.1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67470670): dwResult=0
2019.07.22 12:53:58.584 *D* [db.query           ] Successful sync query: "INSERT INTO idata_2694021 (item_id,idata_timestamp,idata_value) VALUES (4442,1563780238,'-17')" [0 ms]
2019.07.22 12:53:58.594 *D* Node(TURBHE)->GetItemFromSNMP(.1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67471118): dwResult=0
2019.07.22 12:53:58.594 *D* [db.query           ] Successful sync query: "INSERT INTO idata_2693009 (item_id,idata_timestamp,idata_value) VALUES (5527,1563780238,'-5')" [0 ms]
2019.07.22 12:53:58.595 *D* Node(CHAKAN)->GetItemFromSNMP(.1.3.6.1.4.1.2011.5.25.31.1.1.3.1.32.67470862): dwResult=0
2019.07.22 12:53:58.595 *D* [db.query           ] Successful sync query: "INSERT INTO idata_2694021 (item_id,idata_timestamp,idata_value) VALUES (4443,1563780238,'-10')" [0 ms]
2019.07.22 12:53:58.597 *D* AdHocScheduler: run scheduled task with id = 213, execution time = 1563780238
2019.07.22 12:53:58.598 *D* AdHocScheduler: sleeping for 43 seconds
2019.07.22 12:53:58.598 *D* [action             ] Executing scheduled action [1] for event (null) on node [251265]
2019.07.22 12:53:58.598 *D* [action             ] Executing action 1 (Link Down) of type SEND EMAIL
Segmentation fault
Title: Re: Netxms Service not starting
Post by: Victor Kirhenshtein on August 02, 2019, 12:50:22 PM
So server process is crashing. Please enable core dumps and either send coredump to us or get stack trace from it with gdb. You can also run netxmsd under debugger and get stack trace directly from there. Here is short instruction: https://wiki.netxms.org/wiki/Running_NetXMS_under_debugger (https://wiki.netxms.org/wiki/Running_NetXMS_under_debugger)

Best regards,
Victor
Text only | Text with Images