[SNMP4J] agent with own mib
Martin Fischer
fischerm at it.uts.edu.au
Thu Jan 17 23:18:59 CET 2008
Frank Fock schrieb:
> Hi Martin,
>
> You are right, the upper bound must be the same as the
> lower bound for GET requests. Are you using the
> latest version? Unmodified?
Yes we do and we found the error. (Basically it was between my ears! ;-) )
We used the wrong user to log in via SNMPv3. As soon as we changed that
it was working. To be honest I don't really know why it is working (as I
said the log files seemed to be alright before) but I don't really care
as long as it does.
Thank you anyway.
Martin
>
> Best regards,
> Frank
>
> Martin Fischer wrote:
>> Is it possible that following line is not correct??
>>
>> 17445 [RequestPool.0] DEBUG org.snmp4j.agent.request.SnmpRequest -
>> Created subrequest 0 with scope
>> org.snmp4j.agent.DefaultMOContextScope[context=,lowerBound=1.3.6.1.3.1.2.0,lowerIncluded=true,upperBound=1.3.6.1.3.1.2.0,upperIncluded=true]
>> from 1.3.6.1.3.1.2.0 = Null
>>
>> Is the "= Null" correct?
>>
>> Martin
>>
>> Martin Fischer schrieb:
>>> Hi everybody,
>>> I posted earlier in December that I have some issues with our own
>>> mib. I think I have made some progress since then but still it
>>> doesn't work properly.
>>> The MIB contains a scalar that holds an IP adress. I can see in the
>>> log that the value of the scalar is set correctly
>>> org.snmp4j.agent.mo.MOScalar[oid=1.3.6.1.3.1.1.0,access=org.snmp4j.agent.mo.MOAccessImpl at 1837697,value=138.25.13.159,volatile=false]
>>>
>>>
>>> When I want to poll OID 1.3.6.1.3.1.1.0 with a MIB browser the logs
>>> also look ok
>>>
>>> 62750 [DefaultUDPTransportMapping_0.0.0.0/161] DEBUG
>>> org.snmp4j.transport.DefaultUdpTransportMapping - Received message
>>> from /127.0.0.1/2386 with length 73:
>>> 30:47:02:01:03:30:10:02:04:2a:88:11:3f:02:02:40:00:04:01:04:02:01:03:04:1a:30:18:04:00:02:01:00:02:04:47:8c:18:7f:04:07:69:6e:69:74:69:61:6c:04:00:04:00:30:14:04:00:04:00:a0:0e:02:04:2a:88:11:3f:02:01:00:02:01:00:30:00
>>>
>>> 62750 [DefaultUDPTransportMapping_0.0.0.0/161] DEBUG
>>> org.snmp4j.mp.MPv3 - SNMPv3 header decoded: msgId=713560383,
>>> msgMaxSize=16384, msgFlags=04, secModel=3
>>> 62750 [DefaultUDPTransportMapping_0.0.0.0/161] DEBUG
>>> org.snmp4j.security.USM - RFC3414 §3.2.3 Unknown engine ID:
>>> 62750 [DefaultUDPTransportMapping_0.0.0.0/161] DEBUG
>>> org.snmp4j.mp.MPv3 - Adding cache entry:
>>> StateReference[msgID=713560383,pduHandle=PduHandle[1472516069],securityEngineID=,securityModel=org.snmp4j.security.USM at 1ef9f1d,securityName=initial,securityLevel=1,contextEngineID=,contextName=]
>>>
>>> 62760 [DefaultUDPTransportMapping_0.0.0.0/161] DEBUG
>>> org.snmp4j.mp.MPv3 - Removed cache entry:
>>> StateReference[msgID=713560383,pduHandle=PduHandle[1472516069],securityEngineID=,securityModel=org.snmp4j.security.USM at 1ef9f1d,securityName=initial,securityLevel=1,contextEngineID=,contextName=]
>>>
>>> 62760 [DefaultUDPTransportMapping_0.0.0.0/161] DEBUG
>>> org.snmp4j.security.USM - RFC3414 §3.1.4.b Outgoing message is not
>>> encrypted
>>> 62760 [DefaultUDPTransportMapping_0.0.0.0/161] DEBUG
>>> org.snmp4j.transport.DefaultUdpTransportMapping - Sending message to
>>> 127.0.0.1/2386 with length 94:
>>> 30:5c:02:01:03:30:11:02:04:2a:88:11:3f:02:03:00:ff:ff:04:01:00:02:01:03:04:20:30:1e:04:09:80:00:13:70:01:8a:19:0d:55:02:01:00:02:01:00:04:07:69:6e:69:74:69:61:6c:04:00:04:00:30:22:04:00:04:00:a8:1c:02:01:00:02:01:00:02:01:00:30:11:30:0f:06:0a:2b:06:01:06:03:0f:01:01:04:00:41:01:05
>>>
>>> 62770 [DefaultUDPTransportMapping_0.0.0.0/161] WARN
>>> org.snmp4j.MessageDispatcherImpl - 1.3.6.1.6.3.15.1.1.4.0 = 5
>>> 62770 [DefaultUDPTransportMapping_0.0.0.0/161] DEBUG
>>> org.snmp4j.transport.DefaultUdpTransportMapping - Received message
>>> from /127.0.0.1/2386 with length 97:
>>> 30:5f:02:01:03:30:10:02:04:2a:88:11:41:02:02:40:00:04:01:05:02:01:03:04:29:30:27:04:09:80:00:13:70:01:8a:19:0d:55:02:01:00:02:01:00:04:04:54:45:53:54:04:0c:ca:81:44:b4:5f:ee:2d:df:4d:06:6b:19:04:00:30:1d:04:09:80:00:13:70:01:8a:19:0d:55:04:00:a0:0e:02:04:2a:88:11:41:02:01:00:02:01:00:30:00
>>>
>>> 62770 [DefaultUDPTransportMapping_0.0.0.0/161] DEBUG
>>> org.snmp4j.mp.MPv3 - SNMPv3 header decoded: msgId=713560385,
>>> msgMaxSize=16384, msgFlags=05, secModel=3
>>> 62770 [DefaultUDPTransportMapping_0.0.0.0/161] DEBUG
>>> org.snmp4j.security.USM -
>>> getUser(engineID=80:00:13:70:01:8a:19:0d:55, securityName=TEST)
>>> 62770 [DefaultUDPTransportMapping_0.0.0.0/161] DEBUG
>>> org.snmp4j.security.UsmTimeTable - CheckTime: received message
>>> outside time window (authorative):engineBoots differ
>>> 62770 [DefaultUDPTransportMapping_0.0.0.0/161] DEBUG
>>> org.snmp4j.security.USM - RFC3414 §3.2.7.a Not in time window;
>>> engineID='80:00:13:70:01:8a:19:0d:55', engineBoots=0, engineTime=0
>>> 62770 [DefaultUDPTransportMapping_0.0.0.0/161] DEBUG
>>> org.snmp4j.mp.MPv3 - Adding cache entry:
>>> StateReference[msgID=713560385,pduHandle=PduHandle[1472516070],securityEngineID=80:00:13:70:01:8a:19:0d:55,securityModel=org.snmp4j.security.USM at 1ef9f1d,securityName=TEST,securityLevel=2,contextEngineID=,contextName=]
>>>
>>> 62770 [DefaultUDPTransportMapping_0.0.0.0/161] DEBUG
>>> org.snmp4j.mp.MPv3 - Removed cache entry:
>>> StateReference[msgID=713560385,pduHandle=PduHandle[1472516070],securityEngineID=80:00:13:70:01:8a:19:0d:55,securityModel=org.snmp4j.security.USM at 1ef9f1d,securityName=TEST,securityLevel=2,contextEngineID=,contextName=]
>>>
>>> 62770 [DefaultUDPTransportMapping_0.0.0.0/161] DEBUG
>>> org.snmp4j.security.USM - RFC3414 §3.1.4.b Outgoing message is not
>>> encrypted
>>> 62780 [DefaultUDPTransportMapping_0.0.0.0/161] DEBUG
>>> org.snmp4j.transport.DefaultUdpTransportMapping - Sending message to
>>> 127.0.0.1/2386 with length 103:
>>> 30:65:02:01:03:30:11:02:04:2a:88:11:41:02:03:00:ff:ff:04:01:01:02:01:03:04:29:30:27:04:09:80:00:13:70:01:8a:19:0d:55:02:01:4b:02:01:3e:04:04:54:45:53:54:04:0c:8f:d5:af:ea:8d:0e:8c:3e:58:87:4a:22:04:00:30:22:04:00:04:00:a8:1c:02:01:00:02:01:00:02:01:00:30:11:30:0f:06:0a:2b:06:01:06:03:0f:01:01:02:00:41:01:05
>>>
>>> 62790 [DefaultUDPTransportMapping_0.0.0.0/161] WARN
>>> org.snmp4j.MessageDispatcherImpl - 1.3.6.1.6.3.15.1.1.2.0 = 5
>>> 62790 [DefaultUDPTransportMapping_0.0.0.0/161] DEBUG
>>> org.snmp4j.transport.DefaultUdpTransportMapping - Received message
>>> from /127.0.0.1/2386 with length 124:
>>> 30:7a:02:01:03:30:10:02:04:2a:88:11:3e:02:02:40:00:04:01:07:02:01:03:04:31:30:2f:04:09:80:00:13:70:01:8a:19:0d:55:02:01:4b:02:01:3e:04:04:54:45:53:54:04:0c:77:13:d8:b0:f4:66:f2:57:e7:80:dd:51:04:08:37:70:07:07:57:f0:6f:32:04:30:3a:67:da:15:13:e5:d0:7c:92:db:c1:9c:bc:ba:bf:57:d0:a4:20:41:a2:10:57:5a:8b:28:2e:94:67:ee:fe:7f:77:4c:5a:10:a1:9a:14:62:f4:67:db:98:76:7d:03:fb
>>>
>>> 62790 [DefaultUDPTransportMapping_0.0.0.0/161] DEBUG
>>> org.snmp4j.mp.MPv3 - SNMPv3 header decoded: msgId=713560382,
>>> msgMaxSize=16384, msgFlags=07, secModel=3
>>> 62790 [DefaultUDPTransportMapping_0.0.0.0/161] DEBUG
>>> org.snmp4j.security.USM -
>>> getUser(engineID=80:00:13:70:01:8a:19:0d:55, securityName=TEST)
>>> 62790 [DefaultUDPTransportMapping_0.0.0.0/161] DEBUG
>>> org.snmp4j.security.UsmTimeTable - CheckTime: time ok (authorative)
>>> 62790 [DefaultUDPTransportMapping_0.0.0.0/161] DEBUG
>>> org.snmp4j.mp.MPv3 - RFC3412 §7.2.10 - Received PDU is NOT a
>>> response or internal class message -> unchanged PduHandle =
>>> PduHandle[713560382]
>>> 62790 [DefaultUDPTransportMapping_0.0.0.0/161] DEBUG
>>> org.snmp4j.mp.MPv3 - Adding cache entry:
>>> StateReference[msgID=713560382,pduHandle=PduHandle[713560382],securityEngineID=80:00:13:70:01:8a:19:0d:55,securityModel=org.snmp4j.security.USM at 1ef9f1d,securityName=TEST,securityLevel=3,contextEngineID=80:00:13:70:01:8a:19:0d:55,contextName=]
>>>
>>> 62790 [DefaultUDPTransportMapping_0.0.0.0/161] DEBUG org.snmp4j.Snmp
>>> - Fire process PDU event:
>>> CommandResponderEvent[transportMapping=org.snmp4j.transport.DefaultUdpTransportMapping at b5dac4peerAddress=127.0.0.1/2386,
>>> processed=false, pdu=[GET[reqestID=713560382, errorStatus=0,
>>> errorIndex=0, VBS[1.3.6.1.3.1.1.0 = Null]]], securityName=TEST,
>>> securityModel=3, securityLevel=3]
>>> 62790 [RequestPool.0] DEBUG org.snmp4j.agent.mo.snmp.VacmMIB - Found
>>> group name 'v3test' for secName 'TEST and secModel 3
>>> 62790 [RequestPool.0] DEBUG org.snmp4j.agent.mo.snmp.VacmMIB - Got
>>> views
>>> [DefaultMOMutableRow2PC[index=6.118.51.116.101.115.116.0.3.3,values=[1,
>>> testReadView, testWriteView, testNotifyView, 3, 1]] for group name
>>> 'v3test'
>>> 62790 [RequestPool.0] DEBUG org.snmp4j.agent.mo.snmp.VacmMIB -
>>> Matching view found for group name 'v3test' is 'testReadView'
>>> 62790 [RequestPool.0] DEBUG org.snmp4j.agent.request.SnmpRequest -
>>> Created subrequest 0 with scope
>>> org.snmp4j.agent.DefaultMOContextScope[context=,lowerBound=1.3.6.1.3.1.1.0,lowerIncluded=true,upperBound=1.3.6.1.3.1.1.0,upperIncluded=true]
>>> from 1.3.6.1.3.1.1.0 = Null
>>> 62790 [RequestPool.0] DEBUG org.snmp4j.agent.request.SnmpRequest -
>>> SnmpSubRequests initialized:
>>> [org.snmp4j.agent.request.SnmpRequest$SnmpSubRequest[scope=org.snmp4j.agent.DefaultMOContextScope[context=,lowerBound=1.3.6.1.3.1.1.0,lowerIncluded=true,upperBound=1.3.6.1.3.1.1.0,upperIncluded=true],vb=1.3.6.1.3.1.1.0
>>> =
>>> Null,status=org.snmp4j.agent.request.RequestStatus at 290fbc,query=null,index=0,targetMO=null]]
>>>
>>> 62790 [RequestPool.0] DEBUG org.snmp4j.mp.MPv3 - Removed cache
>>> entry:
>>> StateReference[msgID=713560382,pduHandle=PduHandle[713560382],securityEngineID=80:00:13:70:01:8a:19:0d:55,securityModel=org.snmp4j.security.USM at 1ef9f1d,securityName=TEST,securityLevel=3,contextEngineID=80:00:13:70:01:8a:19:0d:55,contextName=]
>>>
>>> 62790 [RequestPool.0] DEBUG org.snmp4j.security.USM - RFC3414
>>> §3.1.4.a Outgoing message needs to be encrypted
>>> 62790 [RequestPool.0] DEBUG org.snmp4j.security.PrivDES - Preparing
>>> decrypt_params.
>>> 62790 [RequestPool.0] DEBUG org.snmp4j.security.PrivDES - Preparing
>>> iv for encryption.
>>> 62790 [RequestPool.0] DEBUG org.snmp4j.security.PrivDES - Using
>>> padding.
>>> 62790 [RequestPool.0] DEBUG org.snmp4j.security.PrivDES - Encryption
>>> finished.
>>> 62790 [RequestPool.0] DEBUG
>>> org.snmp4j.transport.DefaultUdpTransportMapping - Sending message to
>>> 127.0.0.1/2386 with length 125:
>>> 30:7b:02:01:03:30:11:02:04:2a:88:11:3e:02:03:00:ff:ff:04:01:03:02:01:03:04:31:30:2f:04:09:80:00:13:70:01:8a:19:0d:55:02:01:4b:02:01:3e:04:04:54:45:53:54:04:0c:a0:dd:ca:cb:35:f9:83:3c:e0:57:d8:a3:04:08:00:00:00:4b:ce:52:49:66:04:30:7d:f4:96:b1:47:38:2d:4e:ea:5b:23:c8:6c:65:20:61:97:8e:8c:f7:a1:3d:da:c5:97:b3:a7:1e:da:ba:51:c5:e1:d0:6d:4e:86:e2:a7:a5:1f:01:f4:89:ce:4c:a2:26
>>>
>>>
>>> The right user and view is recognized but the MIB browser says:
>>> SNMP no such object
>>>
>>> Any ideas?
>>>
>>> Thanks in advance
>>> Martin
>>> _______________________________________________
>>> SNMP4J mailing list
>>> SNMP4J at agentpp.org
>>> http://lists.agentpp.org/mailman/listinfo/snmp4j
>> _______________________________________________
>> SNMP4J mailing list
>> SNMP4J at agentpp.org
>> http://lists.agentpp.org/mailman/listinfo/snmp4j
>
More information about the SNMP4J
mailing list