libplctag/libplctag.NET

Timeout Micro850 (2080-LC50-24QBB)

fiddlydigit opened this issue · 4 comments

fiddlydigit commented

I always get timeout trying to return a tag. I have tried removing Path but instead of Timeout I get BadParam exception. Am I missing something? Thanks in advance.

public static Tag Test()
    {

        var myTag = new Tag()
        {
            Name = "Programs:SomeProgram.SomeDint",
            Path = "1,0",
            Gateway = "192.168.100.199",
            PlcType = PlcType.Micro800,
            Protocol = Protocol.ab_eip,
        
            //A global timeout value that is used for Initialize/Read/Write methods
            Timeout = TimeSpan.FromSeconds(1)
        };
        myTag.Initialize();
        return myTag;
    }

image

Log with Path parameter

Info 2023-04-14 13:03:41.588 thread(1) tag(0) INFO plc_tag_create_ex:838 Starting
Info 2023-04-14 13:03:41.598 thread(1) tag(0) INFO initialize_modules:177 Starting.
Info 2023-04-14 13:03:41.598 thread(1) tag(0) INFO initialize_modules:186 Creating library mutex.
Detail 2023-04-14 13:03:41.598 thread(1) tag(0) DETAIL mutex_create:726 Starting.
Detail 2023-04-14 13:03:41.598 thread(1) tag(0) DETAIL mutex_create:753 Done.
Info 2023-04-14 13:03:41.598 thread(1) tag(0) INFO initialize_modules:207 Initializing library modules.
Info 2023-04-14 13:03:41.598 thread(1) tag(0) INFO lib_init:136 Starting.
Info 2023-04-14 13:03:41.599 thread(1) tag(0) INFO lib_init:140 Setting up global library data.
Info 2023-04-14 13:03:41.599 thread(1) tag(0) INFO lib_init:142 Creating tag hashtable.
Info 2023-04-14 13:03:41.599 thread(1) tag(0) INFO hashtable_create:75 Starting
Info 2023-04-14 13:03:41.599 thread(1) tag(0) INFO hashtable_create:99 Done
Info 2023-04-14 13:03:41.600 thread(1) tag(0) INFO lib_init:148 Creating tag hashtable mutex.
Detail 2023-04-14 13:03:41.600 thread(1) tag(0) DETAIL mutex_create:726 Starting.
Detail 2023-04-14 13:03:41.600 thread(1) tag(0) DETAIL mutex_create:753 Done.
Info 2023-04-14 13:03:41.600 thread(1) tag(0) INFO lib_init:154 Creating tag condition variable.
Detail 2023-04-14 13:03:41.601 thread(1) tag(0) DETAIL cond_create:1087 Starting.
Detail 2023-04-14 13:03:41.601 thread(1) tag(0) DETAIL cond_create:1114 Done.
Info 2023-04-14 13:03:41.601 thread(1) tag(0) INFO lib_init:160 Creating tag tickler thread.
Detail 2023-04-14 13:03:41.601 thread(1) tag(0) DETAIL thread_create:884 Starting.
Detail 2023-04-14 13:03:41.602 thread(1) tag(0) DETAIL thread_create:917 Done.
Info 2023-04-14 13:03:41.602 thread(1) tag(0) INFO lib_init:166 Done.
Info 2023-04-14 13:03:41.603 thread(1) tag(0) INFO initialize_modules:210 Initializing AB module.
Info 2023-04-14 13:03:41.603 thread(1) tag(0) INFO ab_init:123 Initializing AB protocol library.
Detail 2023-04-14 13:03:41.603 thread(1) tag(0) DETAIL mutex_create:726 Starting.
Detail 2023-04-14 13:03:41.604 thread(1) tag(0) DETAIL mutex_create:753 Done.
Info 2023-04-14 13:03:41.603 thread(2) tag(0) INFO tag_tickler_func:513 Starting.
Info 2023-04-14 13:03:41.604 thread(1) tag(0) INFO ab_init:132 Finished initializing AB protocol library.
Info 2023-04-14 13:03:41.604 thread(1) tag(0) INFO initialize_modules:215 Initializing Modbus module.
Info 2023-04-14 13:03:41.604 thread(1) tag(0) INFO mb_init:2467 Starting.
Detail 2023-04-14 13:03:41.606 thread(1) tag(0) DETAIL mb_init:2469 Setting up mutex.
Detail 2023-04-14 13:03:41.606 thread(1) tag(0) DETAIL mutex_create:726 Starting.
Detail 2023-04-14 13:03:41.606 thread(1) tag(0) DETAIL mutex_create:753 Done.
Info 2023-04-14 13:03:41.606 thread(1) tag(0) INFO mb_init:2478 Done.
Info 2023-04-14 13:03:41.606 thread(1) tag(0) INFO initialize_modules:226 Done initializing library modules.
Info 2023-04-14 13:03:41.607 thread(1) tag(0) INFO initialize_modules:231 Done.
Detail 2023-04-14 13:03:41.607 thread(1) tag(0) DETAIL attr_create_from_str:129 Starting.
Detail 2023-04-14 13:03:41.607 thread(1) tag(0) DETAIL attr_create_from_str:158 Key-value pair "protocol=ab_eip".
Detail 2023-04-14 13:03:41.607 thread(1) tag(0) DETAIL attr_create_from_str:173 Key-value pair before trimming "protocol":"ab_eip".
Detail 2023-04-14 13:03:41.607 thread(1) tag(0) DETAIL attr_create_from_str:185 Key-value pair after trimming "protocol":"ab_eip".
Detail 2023-04-14 13:03:41.608 thread(1) tag(0) DETAIL attr_create_from_str:158 Key-value pair "gateway=192.168.100.199".
Detail 2023-04-14 13:03:41.608 thread(1) tag(0) DETAIL attr_create_from_str:173 Key-value pair before trimming "gateway":"192.168.100.199".
Detail 2023-04-14 13:03:41.608 thread(1) tag(0) DETAIL attr_create_from_str:185 Key-value pair after trimming "gateway":"192.168.100.199".
Detail 2023-04-14 13:03:41.608 thread(1) tag(0) DETAIL attr_create_from_str:158 Key-value pair "path=1,0".
Detail 2023-04-14 13:03:41.609 thread(1) tag(0) DETAIL attr_create_from_str:173 Key-value pair before trimming "path":"1,0".
Detail 2023-04-14 13:03:41.609 thread(1) tag(0) DETAIL attr_create_from_str:185 Key-value pair after trimming "path":"1,0".
Detail 2023-04-14 13:03:41.609 thread(1) tag(0) DETAIL attr_create_from_str:158 Key-value pair "plc=micro800".
Detail 2023-04-14 13:03:41.609 thread(1) tag(0) DETAIL attr_create_from_str:173 Key-value pair before trimming "plc":"micro800".
Detail 2023-04-14 13:03:41.609 thread(1) tag(0) DETAIL attr_create_from_str:185 Key-value pair after trimming "plc":"micro800".
Detail 2023-04-14 13:03:41.609 thread(1) tag(0) DETAIL attr_create_from_str:158 Key-value pair "elem_size=4".
Detail 2023-04-14 13:03:41.609 thread(1) tag(0) DETAIL attr_create_from_str:173 Key-value pair before trimming "elem_size":"4".
Detail 2023-04-14 13:03:41.609 thread(1) tag(0) DETAIL attr_create_from_str:185 Key-value pair after trimming "elem_size":"4".
Detail 2023-04-14 13:03:41.609 thread(1) tag(0) DETAIL attr_create_from_str:158 Key-value pair "name=Programs:SomeProgram.SomeDint".
Detail 2023-04-14 13:03:41.609 thread(1) tag(0) DETAIL attr_create_from_str:173 Key-value pair before trimming "name":"Programs:SomeProgram.SomeDint".
Detail 2023-04-14 13:03:41.610 thread(1) tag(0) DETAIL attr_create_from_str:185 Key-value pair after trimming "name":"Programs:SomeProgram.SomeDint".
Detail 2023-04-14 13:03:41.610 thread(1) tag(0) DETAIL attr_create_from_str:158 Key-value pair "debug=4".
Detail 2023-04-14 13:03:41.610 thread(1) tag(0) DETAIL attr_create_from_str:173 Key-value pair before trimming "debug":"4".
Detail 2023-04-14 13:03:41.610 thread(1) tag(0) DETAIL attr_create_from_str:185 Key-value pair after trimming "debug":"4".
Detail 2023-04-14 13:03:41.611 thread(1) tag(0) DETAIL attr_create_from_str:216 Done.
Info 2023-04-14 13:03:41.611 thread(1) tag(0) INFO find_tag_create_func:99 Matched protocol=ab_eip
Info 2023-04-14 13:03:41.611 thread(1) tag(0) INFO ab_tag_create:173 Starting.
Info 2023-04-14 13:03:41.611 thread(1) tag(0) INFO rc_alloc_impl:111 Starting, called from ab_tag_create:180
Info 2023-04-14 13:03:41.612 thread(1) tag(0) INFO rc_alloc_impl:130 Done
Detail 2023-04-14 13:03:41.612 thread(1) tag(0) DETAIL rc_alloc_impl:135 Returning memory pointer 0000023A672254A0
Detail 2023-04-14 13:03:41.612 thread(1) tag(0) DETAIL ab_tag_create:186 tag=0000023A672254A0
Info 2023-04-14 13:03:41.612 thread(1) tag(0) INFO plc_tag_generic_init_tag:467 Starting.
Detail 2023-04-14 13:03:41.612 thread(1) tag(0) DETAIL mutex_create:726 Starting.
Detail 2023-04-14 13:03:41.612 thread(1) tag(0) DETAIL mutex_create:753 Done.
Detail 2023-04-14 13:03:41.612 thread(1) tag(0) DETAIL mutex_create:726 Starting.
Detail 2023-04-14 13:03:41.612 thread(1) tag(0) DETAIL mutex_create:753 Done.
Detail 2023-04-14 13:03:41.612 thread(1) tag(0) DETAIL cond_create:1087 Starting.
Detail 2023-04-14 13:03:41.612 thread(1) tag(0) DETAIL cond_create:1114 Done.
Info 2023-04-14 13:03:41.612 thread(1) tag(0) INFO plc_tag_generic_init_tag:498 Done.
Detail 2023-04-14 13:03:41.612 thread(1) tag(0) DETAIL get_plc_type:925 Found Micro8xx PLC.
Detail 2023-04-14 13:03:41.612 thread(1) tag(0) DETAIL ab_tag_create:246 Micro800 needs connected messaging.
Detail 2023-04-14 13:03:41.614 thread(1) tag(0) DETAIL get_plc_type:925 Found Micro8xx PLC.
Detail 2023-04-14 13:03:41.614 thread(1) tag(0) DETAIL session_find_or_create:253 Starting
Detail 2023-04-14 13:03:41.614 thread(1) tag(0) DETAIL session_find_or_create:277 Creating new session.
Info 2023-04-14 13:03:41.614 thread(1) tag(0) INFO session_create_unsafe:469 Starting
Detail 2023-04-14 13:03:41.615 thread(1) tag(0) DETAIL session_create_unsafe:472 Session should use connected messaging.
Info 2023-04-14 13:03:41.615 thread(1) tag(0) INFO rc_alloc_impl:111 Starting, called from session_create_unsafe:477
Info 2023-04-14 13:03:41.615 thread(1) tag(0) INFO rc_alloc_impl:130 Done
Detail 2023-04-14 13:03:41.615 thread(1) tag(0) DETAIL rc_alloc_impl:135 Returning memory pointer 0000023A672256F0
Detail 2023-04-14 13:03:41.615 thread(1) tag(0) DETAIL cip_encode_path:71 Starting
Detail 2023-04-14 13:03:41.616 thread(1) tag(0) DETAIL match_numeric_segment:195 Starting at position 0 in string 1,0.
Detail 2023-04-14 13:03:41.616 thread(1) tag(0) DETAIL match_numeric_segment:224 Remaining path ",0".
Detail 2023-04-14 13:03:41.616 thread(1) tag(0) DETAIL match_numeric_segment:229 Done. Found numeric segment 1.
Detail 2023-04-14 13:03:41.616 thread(1) tag(0) DETAIL cip_encode_path:89 Found numeric segment.
Detail 2023-04-14 13:03:41.616 thread(1) tag(0) DETAIL cip_encode_path:85 Skipping separator character ','.
Detail 2023-04-14 13:03:41.616 thread(1) tag(0) DETAIL match_numeric_segment:195 Starting at position 2 in string 1,0.
Detail 2023-04-14 13:03:41.616 thread(1) tag(0) DETAIL match_numeric_segment:224 Remaining path "".
Detail 2023-04-14 13:03:41.616 thread(1) tag(0) DETAIL match_numeric_segment:229 Done. Found numeric segment 0.
Detail 2023-04-14 13:03:41.617 thread(1) tag(0) DETAIL cip_encode_path:89 Found numeric segment.
Detail 2023-04-14 13:03:41.617 thread(1) tag(0) DETAIL cip_encode_path:130 PLC needs connection, adding path to the router object.
Detail 2023-04-14 13:03:41.617 thread(1) tag(0) DETAIL cip_encode_path:162 IOI size before 6
Detail 2023-04-14 13:03:41.617 thread(1) tag(0) DETAIL cip_encode_path:183 Done
Detail 2023-04-14 13:03:41.617 thread(1) tag(0) DETAIL session_create_unsafe:525 Setting connection_group_id to 0.
Detail 2023-04-14 13:03:41.617 thread(1) tag(0) DETAIL session_create_unsafe:565 Set maximum payload size to 508 bytes.
Detail 2023-04-14 13:03:41.617 thread(1) tag(0) DETAIL add_session_unsafe:333 Starting
Detail 2023-04-14 13:03:41.618 thread(1) tag(0) DETAIL add_session_unsafe:343 Done
Info 2023-04-14 13:03:41.618 thread(1) tag(0) INFO session_create_unsafe:582 Done
Info 2023-04-14 13:03:41.618 thread(1) tag(0) INFO session_init:598 Starting.
Detail 2023-04-14 13:03:41.618 thread(1) tag(0) DETAIL mutex_create:726 Starting.
Detail 2023-04-14 13:03:41.618 thread(1) tag(0) DETAIL mutex_create:753 Done.
Detail 2023-04-14 13:03:41.618 thread(1) tag(0) DETAIL cond_create:1087 Starting.
Detail 2023-04-14 13:03:41.618 thread(1) tag(0) DETAIL cond_create:1114 Done.
Detail 2023-04-14 13:03:41.618 thread(1) tag(0) DETAIL thread_create:884 Starting.
Detail 2023-04-14 13:03:41.619 thread(1) tag(0) DETAIL thread_create:917 Done.
Info 2023-04-14 13:03:41.619 thread(1) tag(0) INFO session_init:620 Done.
Info 2023-04-14 13:03:41.619 thread(3) tag(0) INFO session_handler:1032 Starting thread for session 0000023A672256F0
Detail 2023-04-14 13:03:41.620 thread(3) tag(0) DETAIL session_handler:1052 in SESSION_OPEN_SOCKET_START state.
Info 2023-04-14 13:03:41.620 thread(3) tag(0) INFO session_open_socket:638 Starting.
Detail 2023-04-14 13:03:41.620 thread(3) tag(0) DETAIL socket_create:1311 Starting.
Detail 2023-04-14 13:03:41.619 thread(1) tag(0) DETAIL session_find_or_create:323 Done
Detail 2023-04-14 13:03:41.620 thread(1) tag(0) DETAIL ab_tag_create:287 using session=0000023A672256F0
Detail 2023-04-14 13:03:41.621 thread(3) tag(0) DETAIL socket_create:1334 Done.
Detail 2023-04-14 13:03:41.621 thread(3) tag(0) DETAIL session_open_socket:672 Using default port 44818.
Detail 2023-04-14 13:03:41.621 thread(3) tag(0) DETAIL socket_connect_tcp_start:1355 Starting.
Detail 2023-04-14 13:03:41.621 thread(1) tag(0) DETAIL get_tag_data_type:532 Starting.
Info 2023-04-14 13:03:41.621 thread(1) tag(0) INFO get_tag_data_type:645 Setting element size to 4.
Detail 2023-04-14 13:03:41.622 thread(1) tag(0) DETAIL get_tag_data_type:663 Done.
Detail 2023-04-14 13:03:41.622 thread(1) tag(0) DETAIL ab_tag_create:381 Setting up Micro8X0 tag.
Detail 2023-04-14 13:03:41.622 thread(3) tag(0) DETAIL socket_connect_tcp_start:1404 Found numeric IP address: 192.168.100.199
Warn 2023-04-14 13:03:41.623 thread(1) tag(0) WARN ab_tag_create:384 A path is not supported for this PLC type.
Detail 2023-04-14 13:03:41.623 thread(3) tag(0) DETAIL socket_connect_tcp_start:1444 Setting up wake pipe.
Info 2023-04-14 13:03:41.627 thread(3) tag(0) INFO sock_create_event_wakeup_channel:2161 Starting.
Detail 2023-04-14 13:03:41.624 thread(1) tag(0) DETAIL ab_tag_create:389 Using default Micro8x0 byte order.
Detail 2023-04-14 13:03:41.627 thread(1) tag(0) DETAIL ab_tag_create:395 Setting default Logix vtable.
Info 2023-04-14 13:03:41.627 thread(3) tag(0) INFO sock_create_event_wakeup_channel:2308 Done.
Detail 2023-04-14 13:03:41.627 thread(1) tag(0) DETAIL parse_symbolic_segment:720 Starting with name index=0 and encoded name index=1.
Detail 2023-04-14 13:03:41.628 thread(1) tag(0) DETAIL parse_symbolic_segment:759 Parsed symbolic segment "Programs:SomeProgram" in tag name.
Detail 2023-04-14 13:03:41.628 thread(3) tag(0) DETAIL socket_connect_tcp_start:1475 Socket connection attempt 0 started successfully.
Detail 2023-04-14 13:03:41.628 thread(1) tag(0) DETAIL parse_symbolic_segment:720 Starting with name index=21 and encoded name index=23.
Detail 2023-04-14 13:03:41.629 thread(1) tag(0) DETAIL parse_symbolic_segment:759 Parsed symbolic segment "SomeDint" in tag name.
Detail 2023-04-14 13:03:41.629 thread(1) tag(0) DETAIL cip_encode_tag_name:622 Found symbolic segment ending at 29
Detail 2023-04-14 13:03:41.629 thread(1) tag(0) DETAIL ab_tag_create:500 Kicking off initial read.
Info 2023-04-14 13:03:41.630 thread(1) tag(0) INFO tag_read_start:307 Starting
Info 2023-04-14 13:03:41.630 thread(1) tag(0) INFO build_read_request_connected:418 Starting.
Detail 2023-04-14 13:03:41.630 thread(1) tag(0) DETAIL session_create_request:2517 Starting.
Info 2023-04-14 13:03:41.631 thread(1) tag(0) INFO rc_alloc_impl:111 Starting, called from session_create_request:2526
Detail 2023-04-14 13:03:41.628 thread(3) tag(0) DETAIL socket_connect_tcp_start:1501 Done.
Info 2023-04-14 13:03:41.631 thread(1) tag(0) INFO rc_alloc_impl:130 Done
Detail 2023-04-14 13:03:41.631 thread(1) tag(0) DETAIL rc_alloc_impl:135 Returning memory pointer 0000023A6546B680
Info 2023-04-14 13:03:41.631 thread(3) tag(0) INFO session_open_socket:687 Done.
Detail 2023-04-14 13:03:41.632 thread(1) tag(0) DETAIL session_create_request:2540 Done.
Info 2023-04-14 13:03:41.632 thread(1) tag(0) INFO session_add_request:960 Starting. sess=0000023A672256F0, req=0000023A6546B680
Detail 2023-04-14 13:03:41.632 thread(1) tag(0) DETAIL session_add_request_unsafe:925 Starting.
Detail 2023-04-14 13:03:41.633 thread(1) tag(0) DETAIL session_add_request_unsafe:944 Total requests in the queue: 1
Detail 2023-04-14 13:03:41.632 thread(3) tag(0) DETAIL session_handler:1068 Connect started, going to state SESSION_OPEN_SOCKET_WAIT.
Detail 2023-04-14 13:03:41.633 thread(1) tag(0) DETAIL session_add_request_unsafe:946 Done.
Info 2023-04-14 13:03:41.634 thread(1) tag(0) INFO session_add_request:968 Done.
Detail 2023-04-14 13:03:41.634 thread(3) tag(0) DETAIL session_handler:1080 in SESSION_OPEN_SOCKET_WAIT state.
Info 2023-04-14 13:03:41.634 thread(1) tag(0) INFO build_read_request_connected:503 Done
Detail 2023-04-14 13:03:41.634 thread(3) tag(0) DETAIL socket_connect_tcp_check:1518 Starting.
Info 2023-04-14 13:03:41.634 thread(1) tag(0) INFO tag_read_start:336 Done.
Detail 2023-04-14 13:03:41.635 thread(1) tag(0) DETAIL ab_tag_create:513 Using vtable 00007FFD56095120.
Info 2023-04-14 13:03:41.635 thread(1) tag(0) INFO ab_tag_create:515 Done.
Info 2023-04-14 13:03:41.636 thread(1) tag(0) INFO set_tag_byte_order:3926 Starting.
Info 2023-04-14 13:03:41.636 thread(1) tag(0) INFO set_tag_byte_order:4227 Done.
Detail 2023-04-14 13:03:41.636 thread(1) tag(0) DETAIL add_tag_lookup:4330 Starting.
Detail 2023-04-14 13:03:41.636 thread(1) tag(0) DETAIL add_tag_lookup:4350 Found unused ID 11
Detail 2023-04-14 13:03:41.637 thread(1) tag(0) DETAIL add_tag_lookup:4370 Done.
Info 2023-04-14 13:03:41.638 thread(1) tag(11) INFO plc_tag_create_ex:973 Returning mapped tag ID 11
Detail 2023-04-14 13:03:41.638 thread(1) tag(11) DETAIL plc_tag_create_ex:999 Tag status after creation is PLCTAG_STATUS_PENDING.
Detail 2023-04-14 13:03:41.638 thread(1) tag(11) DETAIL plc_tag_tickler_wake_impl:220 Starting. Called from plc_tag_create_ex:1010.
Detail 2023-04-14 13:03:41.638 thread(1) tag(11) DETAIL plc_tag_tickler_wake_impl:233 Done. Called from plc_tag_create_ex:1010.
Detail 2023-04-14 13:03:41.639 thread(2) tag(11) DETAIL tag_tickler_func:550 Tickling tag 11.
Detail 2023-04-14 13:03:41.639 thread(2) tag(11) DETAIL plc_tag_generic_tickler:281 Tickling tag 11.
Detail 2023-04-14 13:03:41.639 thread(2) tag(11) DETAIL plc_tag_generic_tickler:386 Done.
Detail 2023-04-14 13:03:41.639 thread(2) tag(0) DETAIL check_read_request_status:1106 Read not ready with status PLCTAG_STATUS_PENDING.
Detail 2023-04-14 13:03:41.640 thread(2) tag(0) DETAIL check_read_status_connected:1345 Read request status is not OK.
Detail 2023-04-14 13:03:41.668 thread(3) tag(0) DETAIL socket_connect_tcp_check:1548 Socket connection not done yet.
Detail 2023-04-14 13:03:41.668 thread(3) tag(0) DETAIL socket_connect_tcp_check:1598 Done.
Detail 2023-04-14 13:03:41.668 thread(3) tag(0) DETAIL session_handler:1093 Still waiting for connection to succeed.
Detail 2023-04-14 13:03:41.669 thread(3) tag(0) DETAIL session_handler:1080 in SESSION_OPEN_SOCKET_WAIT state.
Detail 2023-04-14 13:03:41.669 thread(3) tag(0) DETAIL socket_connect_tcp_check:1518 Starting.
Detail 2023-04-14 13:03:41.700 thread(3) tag(0) DETAIL socket_connect_tcp_check:1548 Socket connection not done yet.
Detail 2023-04-14 13:03:41.700 thread(3) tag(0) DETAIL socket_connect_tcp_check:1598 Done.
Detail 2023-04-14 13:03:41.701 thread(3) tag(0) DETAIL session_handler:1093 Still waiting for connection to succeed.
Detail 2023-04-14 13:03:41.701 thread(3) tag(0) DETAIL session_handler:1080 in SESSION_OPEN_SOCKET_WAIT state.
Detail 2023-04-14 13:03:41.701 thread(3) tag(0) DETAIL socket_connect_tcp_check:1518 Starting.
Detail 2023-04-14 13:03:41.731 thread(3) tag(0) DETAIL socket_connect_tcp_check:1548 Socket connection not done yet.
Detail 2023-04-14 13:03:41.731 thread(3) tag(0) DETAIL socket_connect_tcp_check:1598 Done.
Detail 2023-04-14 13:03:41.731 thread(3) tag(0) DETAIL session_handler:1093 Still waiting for connection to succeed.
Detail 2023-04-14 13:03:41.731 thread(3) tag(0) DETAIL session_handler:1080 in SESSION_OPEN_SOCKET_WAIT state.
Detail 2023-04-14 13:03:41.732 thread(3) tag(0) DETAIL socket_connect_tcp_check:1518 Starting.
Detail 2023-04-14 13:03:41.747 thread(2) tag(0) DETAIL tag_tickler_func:636 Tag tickler thread timed out waiting for something to do.
Detail 2023-04-14 13:03:41.747 thread(2) tag(11) DETAIL tag_tickler_func:550 Tickling tag 11.
Detail 2023-04-14 13:03:41.747 thread(2) tag(11) DETAIL plc_tag_generic_tickler:281 Tickling tag 11.
Detail 2023-04-14 13:03:41.747 thread(2) tag(11) DETAIL plc_tag_generic_tickler:386 Done.
Detail 2023-04-14 13:03:41.748 thread(2) tag(0) DETAIL check_read_request_status:1106 Read not ready with status PLCTAG_STATUS_PENDING.
Detail 2023-04-14 13:03:41.748 thread(2) tag(0) DETAIL check_read_status_connected:1345 Read request status is not OK.
Detail 2023-04-14 13:03:41.762 thread(3) tag(0) DETAIL socket_connect_tcp_check:1548 Socket connection not done yet.
Detail 2023-04-14 13:03:41.763 thread(3) tag(0) DETAIL socket_connect_tcp_check:1598 Done.
Detail 2023-04-14 13:03:41.764 thread(3) tag(0) DETAIL session_handler:1093 Still waiting for connection to succeed.
Detail 2023-04-14 13:03:41.767 thread(3) tag(0) DETAIL session_handler:1080 in SESSION_OPEN_SOCKET_WAIT state.
Detail 2023-04-14 13:03:41.770 thread(3) tag(0) DETAIL socket_connect_tcp_check:1518 Starting.
Detail 2023-04-14 13:03:41.792 thread(3) tag(0) DETAIL socket_connect_tcp_check:1548 Socket connection not done yet.
Detail 2023-04-14 13:03:41.792 thread(3) tag(0) DETAIL socket_connect_tcp_check:1598 Done.
Detail 2023-04-14 13:03:41.792 thread(3) tag(0) DETAIL session_handler:1093 Still waiting for connection to succeed.
Detail 2023-04-14 13:03:41.793 thread(3) tag(0) DETAIL session_handler:1080 in SESSION_OPEN_SOCKET_WAIT state.
Detail 2023-04-14 13:03:41.793 thread(3) tag(0) DETAIL socket_connect_tcp_check:1518 Starting.
Detail 2023-04-14 13:03:41.814 thread(3) tag(0) DETAIL socket_connect_tcp_check:1538 Socket is connected.
Detail 2023-04-14 13:03:41.814 thread(3) tag(0) DETAIL socket_connect_tcp_check:1598 Done.
Info 2023-04-14 13:03:41.814 thread(3) tag(0) INFO session_handler:1086 Socket connection succeeded.
Detail 2023-04-14 13:03:41.815 thread(3) tag(0) DETAIL session_handler:1107 in SESSION_REGISTER state.
Info 2023-04-14 13:03:41.815 thread(3) tag(0) INFO session_register:700 Starting.
Info 2023-04-14 13:03:41.815 thread(3) tag(0) INFO send_eip_request:1870 Starting.
Info 2023-04-14 13:03:41.815 thread(3) tag(0) INFO send_eip_request:1883 Sending packet of size 28
Info 2023-04-14 13:03:41.816 thread(3) tag(0) INFO send_eip_request:1884 00000 65 00 04 00 00 00 00 00 00 00 00 00 00 00 00 00
Info 2023-04-14 13:03:41.816 thread(3) tag(0) INFO send_eip_request:1884 00016 00 00 00 00 00 00 00 00 01 00 00 00
Detail 2023-04-14 13:03:41.816 thread(3) tag(0) DETAIL socket_write:1945 Starting.
Detail 2023-04-14 13:03:41.817 thread(3) tag(0) DETAIL socket_write:2072 Done: result = 28.
Info 2023-04-14 13:03:41.817 thread(3) tag(0) INFO send_eip_request:1926 Done.
Info 2023-04-14 13:03:41.817 thread(3) tag(0) INFO recv_eip_response:1946 Starting.
Detail 2023-04-14 13:03:41.817 thread(3) tag(0) DETAIL socket_read:1807 Starting.
Detail 2023-04-14 13:03:41.818 thread(3) tag(0) DETAIL socket_read:1934 Done: result = 24.
Detail 2023-04-14 13:03:41.818 thread(3) tag(0) DETAIL socket_read:1807 Starting.
Detail 2023-04-14 13:03:41.818 thread(3) tag(0) DETAIL socket_read:1934 Done: result = 4.
Info 2023-04-14 13:03:41.818 thread(3) tag(0) INFO recv_eip_response:2017 request received all needed data (28 bytes of 28).
Info 2023-04-14 13:03:41.819 thread(3) tag(0) INFO recv_eip_response:2019 00000 65 00 04 00 c1 91 a1 f4 00 00 00 00 00 00 00 00
Info 2023-04-14 13:03:41.820 thread(3) tag(0) INFO recv_eip_response:2019 00016 00 00 00 00 00 00 00 00 01 00 00 00
Info 2023-04-14 13:03:41.820 thread(3) tag(0) INFO recv_eip_response:2026 Done.
Info 2023-04-14 13:03:41.820 thread(3) tag(0) INFO session_register:767 Done.
Detail 2023-04-14 13:03:41.820 thread(3) tag(0) DETAIL session_handler:1123 in SESSION_SEND_FORWARD_OPEN state.
Info 2023-04-14 13:03:41.821 thread(3) tag(0) INFO send_forward_open_request:2064 Starting
Detail 2023-04-14 13:03:41.821 thread(3) tag(0) DETAIL send_forward_open_request:2147 Set maximum payload size guess to 4002 bytes.
Info 2023-04-14 13:03:41.821 thread(3) tag(0) INFO send_extended_forward_open_request:2251 Starting
Info 2023-04-14 13:03:41.821 thread(3) tag(0) INFO send_eip_request:1870 Starting.
Info 2023-04-14 13:03:41.822 thread(3) tag(0) INFO send_eip_request:1883 Sending packet of size 92
Info 2023-04-14 13:03:41.822 thread(3) tag(0) INFO send_eip_request:1884 00000 6f 00 44 00 c1 91 a1 f4 00 00 00 00 9a 1d 00 00
Info 2023-04-14 13:03:41.822 thread(3) tag(0) INFO send_eip_request:1884 00016 00 00 00 00 00 00 00 00 00 00 00 00 01 00 02 00
Info 2023-04-14 13:03:41.822 thread(3) tag(0) INFO send_eip_request:1884 00032 00 00 00 00 b2 00 34 00 5b 02 20 06 24 01 0a 05
Info 2023-04-14 13:03:41.823 thread(3) tag(0) INFO send_eip_request:1884 00048 00 00 00 00 64 44 00 00 c1 2d 3d f3 45 43 50 21
Info 2023-04-14 13:03:41.826 thread(3) tag(0) INFO send_eip_request:1884 00064 01 00 00 00 40 42 0f 00 a2 0f 00 42 40 42 0f 00
Info 2023-04-14 13:03:41.827 thread(3) tag(0) INFO send_eip_request:1884 00080 a2 0f 00 42 a3 03 01 00 20 02 24 01
Detail 2023-04-14 13:03:41.827 thread(3) tag(0) DETAIL socket_write:1945 Starting.
Detail 2023-04-14 13:03:41.827 thread(3) tag(0) DETAIL socket_write:2072 Done: result = 92.
Info 2023-04-14 13:03:41.828 thread(3) tag(0) INFO send_eip_request:1926 Done.
Info 2023-04-14 13:03:41.828 thread(3) tag(0) INFO send_extended_forward_open_request:2310 Done
Info 2023-04-14 13:03:41.828 thread(3) tag(0) INFO send_forward_open_request:2152 Done
Detail 2023-04-14 13:03:41.829 thread(3) tag(0) DETAIL session_handler:1129 Send Forward Open succeeded, going to SESSION_RECEIVE_FORWARD_OPEN state.
Detail 2023-04-14 13:03:41.829 thread(3) tag(0) DETAIL session_handler:1136 in SESSION_RECEIVE_FORWARD_OPEN state.
Info 2023-04-14 13:03:41.829 thread(3) tag(0) INFO receive_forward_open_response:2323 Starting
Info 2023-04-14 13:03:41.829 thread(3) tag(0) INFO recv_eip_response:1946 Starting.
Detail 2023-04-14 13:03:41.830 thread(3) tag(0) DETAIL socket_read:1807 Starting.
Detail 2023-04-14 13:03:41.830 thread(3) tag(0) DETAIL socket_read:1934 Done: result = 24.
Detail 2023-04-14 13:03:41.830 thread(3) tag(0) DETAIL socket_read:1807 Starting.
Detail 2023-04-14 13:03:41.831 thread(3) tag(0) DETAIL socket_read:1934 Done: result = 32.
Info 2023-04-14 13:03:41.831 thread(3) tag(0) INFO recv_eip_response:2017 request received all needed data (56 bytes of 56).
Info 2023-04-14 13:03:41.831 thread(3) tag(0) INFO recv_eip_response:2019 00000 6f 00 20 00 c1 91 a1 f4 00 00 00 00 9a 1d 00 00
Info 2023-04-14 13:03:41.831 thread(3) tag(0) INFO recv_eip_response:2019 00016 00 00 00 00 00 00 00 00 00 00 00 00 05 00 02 00
Info 2023-04-14 13:03:41.832 thread(3) tag(0) INFO recv_eip_response:2019 00032 00 00 00 00 b2 00 10 00 db 00 01 01 11 03 c1 2d
Info 2023-04-14 13:03:41.832 thread(3) tag(0) INFO recv_eip_response:2019 00048 3d f3 45 43 50 21 03 00
Info 2023-04-14 13:03:41.832 thread(3) tag(0) INFO recv_eip_response:2026 Done.
Warn 2023-04-14 13:03:41.832 thread(3) tag(0) WARN receive_forward_open_response:2347 Forward Open command failed, response code: Port Not Available (1)
Warn 2023-04-14 13:03:41.833 thread(3) tag(0) WARN receive_forward_open_response:2372 CIP error code Port Not Available (This error occurs when a port number specified in a
port segment is not available. Consult the documentation of the device to verify the correct port number.)!
Info 2023-04-14 13:03:41.833 thread(3) tag(0) INFO receive_forward_open_response:2390 Done.
Warn 2023-04-14 13:03:41.833 thread(3) tag(0) WARN session_handler:1151 Receive Forward Open failed PLCTAG_ERR_REMOTE_ERR!
Detail 2023-04-14 13:03:41.833 thread(3) tag(0) DETAIL session_handler:1220 in SESSION_UNREGISTER state.
Info 2023-04-14 13:03:41.834 thread(3) tag(0) INFO session_unregister:777 Starting.
Info 2023-04-14 13:03:41.834 thread(3) tag(0) INFO session_unregister:781 Done.
Detail 2023-04-14 13:03:41.834 thread(3) tag(0) DETAIL session_handler:1231 in SESSION_CLOSE_SOCKET state.
Info 2023-04-14 13:03:41.834 thread(3) tag(0) INFO session_close_socket:790 Starting.
Info 2023-04-14 13:03:41.834 thread(3) tag(0) INFO socket_close:2083 Starting.
Info 2023-04-14 13:03:41.835 thread(3) tag(0) INFO socket_close:2119 Done.
Info 2023-04-14 13:03:41.835 thread(3) tag(0) INFO socket_destroy:2128 Starting.
Info 2023-04-14 13:03:41.835 thread(3) tag(0) INFO socket_close:2083 Starting.
Info 2023-04-14 13:03:41.835 thread(3) tag(0) INFO socket_close:2119 Done.
Info 2023-04-14 13:03:41.835 thread(3) tag(0) INFO socket_destroy:2145 Done.
Info 2023-04-14 13:03:41.836 thread(3) tag(0) INFO session_close_socket:798 Done.
Detail 2023-04-14 13:03:41.836 thread(3) tag(0) DETAIL session_handler:1246 in SESSION_START_RETRY state.
Detail 2023-04-14 13:03:41.836 thread(3) tag(0) DETAIL session_handler:1258 in SESSION_WAIT_RETRY state.
Detail 2023-04-14 13:03:41.856 thread(2) tag(0) DETAIL tag_tickler_func:636 Tag tickler thread timed out waiting for something to do.
Detail 2023-04-14 13:03:41.856 thread(2) tag(11) DETAIL tag_tickler_func:550 Tickling tag 11.
Detail 2023-04-14 13:03:41.857 thread(2) tag(11) DETAIL plc_tag_generic_tickler:281 Tickling tag 11.
Detail 2023-04-14 13:03:41.857 thread(2) tag(11) DETAIL plc_tag_generic_tickler:386 Done.
Detail 2023-04-14 13:03:41.858 thread(2) tag(0) DETAIL check_read_request_status:1106 Read not ready with status PLCTAG_STATUS_PENDING.
Detail 2023-04-14 13:03:41.858 thread(2) tag(0) DETAIL check_read_status_connected:1345 Read request status is not OK.
Detail 2023-04-14 13:03:41.947 thread(3) tag(0) DETAIL session_handler:1258 in SESSION_WAIT_RETRY state.
Detail 2023-04-14 13:03:41.962 thread(2) tag(0) DETAIL tag_tickler_func:636 Tag tickler thread timed out waiting for something to do.
Detail 2023-04-14 13:03:41.962 thread(2) tag(11) DETAIL tag_tickler_func:550 Tickling tag 11.
Detail 2023-04-14 13:03:41.963 thread(2) tag(11) DETAIL plc_tag_generic_tickler:281 Tickling tag 11.
Detail 2023-04-14 13:03:41.963 thread(2) tag(11) DETAIL plc_tag_generic_tickler:386 Done.
Detail 2023-04-14 13:03:41.963 thread(2) tag(0) DETAIL check_read_request_status:1106 Read not ready with status PLCTAG_STATUS_PENDING.
Detail 2023-04-14 13:03:41.963 thread(2) tag(0) DETAIL check_read_status_connected:1345 Read request status is not OK.
Detail 2023-04-14 13:03:42.058 thread(3) tag(0) DETAIL session_handler:1258 in SESSION_WAIT_RETRY state.
Detail 2023-04-14 13:03:42.074 thread(2) tag(0) DETAIL tag_tickler_func:636 Tag tickler thread timed out waiting for something to do.
Detail 2023-04-14 13:03:42.074 thread(2) tag(11) DETAIL tag_tickler_func:550 Tickling tag 11.
Detail 2023-04-14 13:03:42.074 thread(2) tag(11) DETAIL plc_tag_generic_tickler:281 Tickling tag 11.
Detail 2023-04-14 13:03:42.074 thread(2) tag(11) DETAIL plc_tag_generic_tickler:386 Done.
Detail 2023-04-14 13:03:42.075 thread(2) tag(0) DETAIL check_read_request_status:1106 Read not ready with status PLCTAG_STATUS_PENDING.
Detail 2023-04-14 13:03:42.075 thread(2) tag(0) DETAIL check_read_status_connected:1345 Read request status is not OK.
Detail 2023-04-14 13:03:42.165 thread(3) tag(0) DETAIL session_handler:1258 in SESSION_WAIT_RETRY state.
Detail 2023-04-14 13:03:42.180 thread(2) tag(0) DETAIL tag_tickler_func:636 Tag tickler thread timed out waiting for something to do.
Detail 2023-04-14 13:03:42.180 thread(2) tag(11) DETAIL tag_tickler_func:550 Tickling tag 11.
Detail 2023-04-14 13:03:42.182 thread(2) tag(11) DETAIL plc_tag_generic_tickler:281 Tickling tag 11.
Detail 2023-04-14 13:03:42.185 thread(2) tag(11) DETAIL plc_tag_generic_tickler:386 Done.
Detail 2023-04-14 13:03:42.191 thread(2) tag(0) DETAIL check_read_request_status:1106 Read not ready with status PLCTAG_STATUS_PENDING.
Detail 2023-04-14 13:03:42.194 thread(2) tag(0) DETAIL check_read_status_connected:1345 Read request status is not OK.
Detail 2023-04-14 13:03:42.276 thread(3) tag(0) DETAIL session_handler:1258 in SESSION_WAIT_RETRY state.
Detail 2023-04-14 13:03:42.292 thread(2) tag(0) DETAIL tag_tickler_func:636 Tag tickler thread timed out waiting for something to do.
Detail 2023-04-14 13:03:42.292 thread(2) tag(11) DETAIL tag_tickler_func:550 Tickling tag 11.
Detail 2023-04-14 13:03:42.292 thread(2) tag(11) DETAIL plc_tag_generic_tickler:281 Tickling tag 11.
Detail 2023-04-14 13:03:42.292 thread(2) tag(11) DETAIL plc_tag_generic_tickler:386 Done.
Detail 2023-04-14 13:03:42.292 thread(2) tag(0) DETAIL check_read_request_status:1106 Read not ready with status PLCTAG_STATUS_PENDING.
Detail 2023-04-14 13:03:42.292 thread(2) tag(0) DETAIL check_read_status_connected:1345 Read request status is not OK.
Detail 2023-04-14 13:03:42.384 thread(3) tag(0) DETAIL session_handler:1258 in SESSION_WAIT_RETRY state.
Detail 2023-04-14 13:03:42.400 thread(2) tag(0) DETAIL tag_tickler_func:636 Tag tickler thread timed out waiting for something to do.
Detail 2023-04-14 13:03:42.400 thread(2) tag(11) DETAIL tag_tickler_func:550 Tickling tag 11.
Detail 2023-04-14 13:03:42.400 thread(2) tag(11) DETAIL plc_tag_generic_tickler:281 Tickling tag 11.
Detail 2023-04-14 13:03:42.401 thread(2) tag(11) DETAIL plc_tag_generic_tickler:386 Done.
Detail 2023-04-14 13:03:42.401 thread(2) tag(0) DETAIL check_read_request_status:1106 Read not ready with status PLCTAG_STATUS_PENDING.
Detail 2023-04-14 13:03:42.401 thread(2) tag(0) DETAIL check_read_status_connected:1345 Read request status is not OK.
Detail 2023-04-14 13:03:42.496 thread(3) tag(0) DETAIL session_handler:1258 in SESSION_WAIT_RETRY state.
Detail 2023-04-14 13:03:42.511 thread(2) tag(0) DETAIL tag_tickler_func:636 Tag tickler thread timed out waiting for something to do.
Detail 2023-04-14 13:03:42.512 thread(2) tag(11) DETAIL tag_tickler_func:550 Tickling tag 11.
Detail 2023-04-14 13:03:42.512 thread(2) tag(11) DETAIL plc_tag_generic_tickler:281 Tickling tag 11.
Detail 2023-04-14 13:03:42.512 thread(2) tag(11) DETAIL plc_tag_generic_tickler:386 Done.
Detail 2023-04-14 13:03:42.513 thread(2) tag(0) DETAIL check_read_request_status:1106 Read not ready with status PLCTAG_STATUS_PENDING.
Detail 2023-04-14 13:03:42.513 thread(2) tag(0) DETAIL check_read_status_connected:1345 Read request status is not OK.
Detail 2023-04-14 13:03:42.605 thread(3) tag(0) DETAIL session_handler:1258 in SESSION_WAIT_RETRY state.
Detail 2023-04-14 13:03:42.619 thread(2) tag(0) DETAIL tag_tickler_func:636 Tag tickler thread timed out waiting for something to do.
Detail 2023-04-14 13:03:42.619 thread(2) tag(11) DETAIL tag_tickler_func:550 Tickling tag 11.
Detail 2023-04-14 13:03:42.620 thread(2) tag(11) DETAIL plc_tag_generic_tickler:281 Tickling tag 11.
Detail 2023-04-14 13:03:42.620 thread(2) tag(11) DETAIL plc_tag_generic_tickler:386 Done.
Detail 2023-04-14 13:03:42.620 thread(2) tag(0) DETAIL check_read_request_status:1106 Read not ready with status PLCTAG_STATUS_PENDING.
Detail 2023-04-14 13:03:42.620 thread(2) tag(0) DETAIL check_read_status_connected:1345 Read request status is not OK.
Warn 2023-04-14 13:03:42.650 thread(1) tag(11) WARN plc_tag_create_ex:1028 Error PLCTAG_ERR_TIMEOUT while waiting for tag creation to complete!
Detail 2023-04-14 13:03:42.650 thread(1) tag(11) DETAIL ab_tag_abort:732 Starting.
Detail 2023-04-14 13:03:42.651 thread(1) tag(11) DETAIL ab_tag_abort:748 Done.
Detail 2023-04-14 13:03:42.651 thread(1) tag(11) DETAIL hashtable_remove:232 Starting
Detail 2023-04-14 13:03:42.652 thread(1) tag(11) DETAIL hashtable_remove:250 Done
Detail 2023-04-14 13:03:42.652 thread(1) tag(11) DETAIL rc_dec_impl:242 Calling cleanup functions due to call at plc_tag_create_ex:1038 for 0000023A672254A0.
Info 2023-04-14 13:03:42.652 thread(1) tag(11) INFO refcount_cleanup:256 Starting
Info 2023-04-14 13:03:42.652 thread(1) tag(11) INFO ab_tag_destroy:800 Starting.
Detail 2023-04-14 13:03:42.653 thread(1) tag(11) DETAIL ab_tag_abort:732 Starting.
Detail 2023-04-14 13:03:42.653 thread(1) tag(11) DETAIL ab_tag_abort:741 Called without a request in flight.
Detail 2023-04-14 13:03:42.653 thread(1) tag(11) DETAIL ab_tag_abort:748 Done.
Detail 2023-04-14 13:03:42.654 thread(1) tag(11) DETAIL ab_tag_destroy:815 Getting ready to release tag session 0000023A672256F0
Detail 2023-04-14 13:03:42.654 thread(1) tag(11) DETAIL ab_tag_destroy:817 Removing tag from session.
Detail 2023-04-14 13:03:42.654 thread(1) tag(11) DETAIL rc_dec_impl:242 Calling cleanup functions due to call at ab_tag_destroy:818 for 0000023A672256F0.
Info 2023-04-14 13:03:42.655 thread(1) tag(11) INFO refcount_cleanup:256 Starting
Info 2023-04-14 13:03:42.655 thread(1) tag(11) INFO session_destroy:809 Starting.
Detail 2023-04-14 13:03:42.655 thread(1) tag(11) DETAIL remove_session:394 Starting.
Detail 2023-04-14 13:03:42.655 thread(1) tag(11) DETAIL remove_session_unsafe:370 Starting
Detail 2023-04-14 13:03:42.656 thread(1) tag(11) DETAIL remove_session_unsafe:385 Done
Detail 2023-04-14 13:03:42.656 thread(1) tag(11) DETAIL remove_session:402 Done.
Info 2023-04-14 13:03:42.656 thread(1) tag(11) INFO session_destroy:820 Session sent 2 packets.
Detail 2023-04-14 13:03:42.656 thread(1) tag(11) DETAIL session_destroy:831 Destroying session thread.
Detail 2023-04-14 13:03:42.656 thread(3) tag(0) DETAIL session_handler:1319 Critical block.
Detail 2023-04-14 13:03:42.657 thread(3) tag(0) DETAIL purge_aborted_requests_unsafe:1353 Session thread releasing aborted request 0000023A6546B680.
Detail 2023-04-14 13:03:42.657 thread(3) tag(0) DETAIL rc_dec_impl:242 Calling cleanup functions due to call at purge_aborted_requests_unsafe:1360 for 0000023A6546B680.
Info 2023-04-14 13:03:42.657 thread(3) tag(0) INFO refcount_cleanup:256 Starting
Detail 2023-04-14 13:03:42.658 thread(3) tag(0) DETAIL request_destroy:2559 Starting.
Detail 2023-04-14 13:03:42.658 thread(3) tag(0) DETAIL request_destroy:2568 Done.
Info 2023-04-14 13:03:42.658 thread(3) tag(0) INFO refcount_cleanup:268 Done.
Detail 2023-04-14 13:03:42.658 thread(3) tag(0) DETAIL purge_aborted_requests_unsafe:1368 Removed 1 aborted requests.
Info 2023-04-14 13:03:42.660 thread(1) tag(11) INFO session_unregister:777 Starting.
Info 2023-04-14 13:03:42.662 thread(1) tag(11) INFO session_unregister:781 Done.
Detail 2023-04-14 13:03:42.662 thread(1) tag(11) DETAIL session_destroy:879 Destroying session condition variable.
Detail 2023-04-14 13:03:42.663 thread(1) tag(11) DETAIL cond_destroy:1242 Starting.
Detail 2023-04-14 13:03:42.663 thread(1) tag(11) DETAIL cond_destroy:1253 Done.
Detail 2023-04-14 13:03:42.663 thread(1) tag(11) DETAIL session_destroy:886 Destroying session mutex.
Detail 2023-04-14 13:03:42.663 thread(1) tag(11) DETAIL mutex_destroy:841 destroying mutex 0000023A67226760
Detail 2023-04-14 13:03:42.663 thread(1) tag(11) DETAIL mutex_destroy:854 Done.
Detail 2023-04-14 13:03:42.664 thread(1) tag(11) DETAIL session_destroy:892 Cleaning up allocated memory for paths and host name.
Info 2023-04-14 13:03:42.664 thread(1) tag(11) INFO session_destroy:908 Done.
Info 2023-04-14 13:03:42.664 thread(1) tag(11) INFO refcount_cleanup:268 Done.
Detail 2023-04-14 13:03:42.664 thread(1) tag(11) DETAIL mutex_destroy:841 destroying mutex 0000023A672254D8
Detail 2023-04-14 13:03:42.664 thread(1) tag(11) DETAIL mutex_destroy:854 Done.
Detail 2023-04-14 13:03:42.664 thread(1) tag(11) DETAIL mutex_destroy:841 destroying mutex 0000023A672254E0
Detail 2023-04-14 13:03:42.664 thread(1) tag(11) DETAIL mutex_destroy:854 Done.
Detail 2023-04-14 13:03:42.664 thread(1) tag(11) DETAIL cond_destroy:1242 Starting.
Detail 2023-04-14 13:03:42.665 thread(1) tag(11) DETAIL cond_destroy:1253 Done.
Info 2023-04-14 13:03:42.665 thread(1) tag(11) INFO ab_tag_destroy:849 Finished releasing all tag resources.
Info 2023-04-14 13:03:42.665 thread(1) tag(11) INFO ab_tag_destroy:851 done
Info 2023-04-14 13:03:42.666 thread(1) tag(11) INFO refcount_cleanup:268 Done.
Detail 2023-04-14 13:03:42.734 thread(2) tag(0) DETAIL tag_tickler_func:636 Tag tickler thread timed out waiting for something to do.
Detail 2023-04-14 13:03:48.369 thread(2) tag(0) DETAIL tag_tickler_func:636 Tag tickler thread timed out waiting for something to do.

Log without Path parameter

Info 2023-04-14 13:10:11.597 thread(1) tag(0) INFO plc_tag_create_ex:838 Starting
Info 2023-04-14 13:10:11.609 thread(1) tag(0) INFO initialize_modules:177 Starting.
Info 2023-04-14 13:10:11.610 thread(1) tag(0) INFO initialize_modules:186 Creating library mutex.
Detail 2023-04-14 13:10:11.610 thread(1) tag(0) DETAIL mutex_create:726 Starting.
Detail 2023-04-14 13:10:11.610 thread(1) tag(0) DETAIL mutex_create:753 Done.
Info 2023-04-14 13:10:11.611 thread(1) tag(0) INFO initialize_modules:207 Initializing library modules.
Info 2023-04-14 13:10:11.611 thread(1) tag(0) INFO lib_init:136 Starting.
Info 2023-04-14 13:10:11.611 thread(1) tag(0) INFO lib_init:140 Setting up global library data.
Info 2023-04-14 13:10:11.611 thread(1) tag(0) INFO lib_init:142 Creating tag hashtable.
Info 2023-04-14 13:10:11.612 thread(1) tag(0) INFO hashtable_create:75 Starting
Info 2023-04-14 13:10:11.612 thread(1) tag(0) INFO hashtable_create:99 Done
Info 2023-04-14 13:10:11.612 thread(1) tag(0) INFO lib_init:148 Creating tag hashtable mutex.
Detail 2023-04-14 13:10:11.613 thread(1) tag(0) DETAIL mutex_create:726 Starting.
Detail 2023-04-14 13:10:11.613 thread(1) tag(0) DETAIL mutex_create:753 Done.
Info 2023-04-14 13:10:11.613 thread(1) tag(0) INFO lib_init:154 Creating tag condition variable.
Detail 2023-04-14 13:10:11.614 thread(1) tag(0) DETAIL cond_create:1087 Starting.
Detail 2023-04-14 13:10:11.619 thread(1) tag(0) DETAIL cond_create:1114 Done.
Info 2023-04-14 13:10:11.619 thread(1) tag(0) INFO lib_init:160 Creating tag tickler thread.
Detail 2023-04-14 13:10:11.619 thread(1) tag(0) DETAIL thread_create:884 Starting.
Detail 2023-04-14 13:10:11.619 thread(1) tag(0) DETAIL thread_create:917 Done.
Info 2023-04-14 13:10:11.620 thread(1) tag(0) INFO lib_init:166 Done.
Info 2023-04-14 13:10:11.620 thread(1) tag(0) INFO initialize_modules:210 Initializing AB module.
Info 2023-04-14 13:10:11.620 thread(2) tag(0) INFO tag_tickler_func:513 Starting.
Info 2023-04-14 13:10:11.620 thread(1) tag(0) INFO ab_init:123 Initializing AB protocol library.
Detail 2023-04-14 13:10:11.622 thread(1) tag(0) DETAIL mutex_create:726 Starting.
Detail 2023-04-14 13:10:11.622 thread(1) tag(0) DETAIL mutex_create:753 Done.
Info 2023-04-14 13:10:11.622 thread(1) tag(0) INFO ab_init:132 Finished initializing AB protocol library.
Info 2023-04-14 13:10:11.622 thread(1) tag(0) INFO initialize_modules:215 Initializing Modbus module.
Info 2023-04-14 13:10:11.622 thread(1) tag(0) INFO mb_init:2467 Starting.
Detail 2023-04-14 13:10:11.622 thread(1) tag(0) DETAIL mb_init:2469 Setting up mutex.
Detail 2023-04-14 13:10:11.623 thread(1) tag(0) DETAIL mutex_create:726 Starting.
Detail 2023-04-14 13:10:11.624 thread(1) tag(0) DETAIL mutex_create:753 Done.
Info 2023-04-14 13:10:11.624 thread(1) tag(0) INFO mb_init:2478 Done.
Info 2023-04-14 13:10:11.625 thread(1) tag(0) INFO initialize_modules:226 Done initializing library modules.
Info 2023-04-14 13:10:11.625 thread(1) tag(0) INFO initialize_modules:231 Done.
Detail 2023-04-14 13:10:11.625 thread(1) tag(0) DETAIL attr_create_from_str:129 Starting.
Detail 2023-04-14 13:10:11.625 thread(1) tag(0) DETAIL attr_create_from_str:158 Key-value pair "protocol=ab_eip".
Detail 2023-04-14 13:10:11.625 thread(1) tag(0) DETAIL attr_create_from_str:173 Key-value pair before trimming "protocol":"ab_eip".
Detail 2023-04-14 13:10:11.625 thread(1) tag(0) DETAIL attr_create_from_str:185 Key-value pair after trimming "protocol":"ab_eip".
Detail 2023-04-14 13:10:11.626 thread(1) tag(0) DETAIL attr_create_from_str:158 Key-value pair "gateway=192.168.100.199".
Detail 2023-04-14 13:10:11.626 thread(1) tag(0) DETAIL attr_create_from_str:173 Key-value pair before trimming "gateway":"192.168.100.199".
Detail 2023-04-14 13:10:11.626 thread(1) tag(0) DETAIL attr_create_from_str:185 Key-value pair after trimming "gateway":"192.168.100.199".
Detail 2023-04-14 13:10:11.626 thread(1) tag(0) DETAIL attr_create_from_str:158 Key-value pair "plc=micro800".
Detail 2023-04-14 13:10:11.626 thread(1) tag(0) DETAIL attr_create_from_str:173 Key-value pair before trimming "plc":"micro800".
Detail 2023-04-14 13:10:11.626 thread(1) tag(0) DETAIL attr_create_from_str:185 Key-value pair after trimming "plc":"micro800".
Detail 2023-04-14 13:10:11.627 thread(1) tag(0) DETAIL attr_create_from_str:158 Key-value pair "elem_size=4".
Detail 2023-04-14 13:10:11.627 thread(1) tag(0) DETAIL attr_create_from_str:173 Key-value pair before trimming "elem_size":"4".
Detail 2023-04-14 13:10:11.627 thread(1) tag(0) DETAIL attr_create_from_str:185 Key-value pair after trimming "elem_size":"4".
Detail 2023-04-14 13:10:11.627 thread(1) tag(0) DETAIL attr_create_from_str:158 Key-value pair "name=Programs:SomeProgram.SomeDint".
Detail 2023-04-14 13:10:11.627 thread(1) tag(0) DETAIL attr_create_from_str:173 Key-value pair before trimming "name":"Programs:SomeProgram.SomeDint".
Detail 2023-04-14 13:10:11.627 thread(1) tag(0) DETAIL attr_create_from_str:185 Key-value pair after trimming "name":"Programs:SomeProgram.SomeDint".
Detail 2023-04-14 13:10:11.627 thread(1) tag(0) DETAIL attr_create_from_str:158 Key-value pair "debug=4".
Detail 2023-04-14 13:10:11.628 thread(1) tag(0) DETAIL attr_create_from_str:173 Key-value pair before trimming "debug":"4".
Detail 2023-04-14 13:10:11.628 thread(1) tag(0) DETAIL attr_create_from_str:185 Key-value pair after trimming "debug":"4".
Detail 2023-04-14 13:10:11.628 thread(1) tag(0) DETAIL attr_create_from_str:216 Done.
Info 2023-04-14 13:10:11.628 thread(1) tag(0) INFO find_tag_create_func:99 Matched protocol=ab_eip
Info 2023-04-14 13:10:11.628 thread(1) tag(0) INFO ab_tag_create:173 Starting.
Info 2023-04-14 13:10:11.628 thread(1) tag(0) INFO rc_alloc_impl:111 Starting, called from ab_tag_create:180
Info 2023-04-14 13:10:11.629 thread(1) tag(0) INFO rc_alloc_impl:130 Done
Detail 2023-04-14 13:10:11.629 thread(1) tag(0) DETAIL rc_alloc_impl:135 Returning memory pointer 00000175CA37A950
Detail 2023-04-14 13:10:11.629 thread(1) tag(0) DETAIL ab_tag_create:186 tag=00000175CA37A950
Info 2023-04-14 13:10:11.629 thread(1) tag(0) INFO plc_tag_generic_init_tag:467 Starting.
Detail 2023-04-14 13:10:11.629 thread(1) tag(0) DETAIL mutex_create:726 Starting.
Detail 2023-04-14 13:10:11.629 thread(1) tag(0) DETAIL mutex_create:753 Done.
Detail 2023-04-14 13:10:11.629 thread(1) tag(0) DETAIL mutex_create:726 Starting.
Detail 2023-04-14 13:10:11.630 thread(1) tag(0) DETAIL mutex_create:753 Done.
Detail 2023-04-14 13:10:11.630 thread(1) tag(0) DETAIL cond_create:1087 Starting.
Detail 2023-04-14 13:10:11.630 thread(1) tag(0) DETAIL cond_create:1114 Done.
Info 2023-04-14 13:10:11.630 thread(1) tag(0) INFO plc_tag_generic_init_tag:498 Done.
Detail 2023-04-14 13:10:11.630 thread(1) tag(0) DETAIL get_plc_type:925 Found Micro8xx PLC.
Detail 2023-04-14 13:10:11.630 thread(1) tag(0) DETAIL ab_tag_create:246 Micro800 needs connected messaging.
Detail 2023-04-14 13:10:11.631 thread(1) tag(0) DETAIL get_plc_type:925 Found Micro8xx PLC.
Detail 2023-04-14 13:10:11.631 thread(1) tag(0) DETAIL session_find_or_create:253 Starting
Detail 2023-04-14 13:10:11.631 thread(1) tag(0) DETAIL session_find_or_create:277 Creating new session.
Info 2023-04-14 13:10:11.631 thread(1) tag(0) INFO session_create_unsafe:469 Starting
Detail 2023-04-14 13:10:11.631 thread(1) tag(0) DETAIL session_create_unsafe:472 Session should use connected messaging.
Info 2023-04-14 13:10:11.631 thread(1) tag(0) INFO rc_alloc_impl:111 Starting, called from session_create_unsafe:477
Info 2023-04-14 13:10:11.632 thread(1) tag(0) INFO rc_alloc_impl:130 Done
Detail 2023-04-14 13:10:11.632 thread(1) tag(0) DETAIL rc_alloc_impl:135 Returning memory pointer 00000175CA3E2440
Detail 2023-04-14 13:10:11.632 thread(1) tag(0) DETAIL cip_encode_path:71 Starting
Detail 2023-04-14 13:10:11.632 thread(1) tag(0) DETAIL cip_encode_path:130 PLC needs connection, adding path to the router object.
Detail 2023-04-14 13:10:11.632 thread(1) tag(0) DETAIL cip_encode_path:162 IOI size before 4
Detail 2023-04-14 13:10:11.632 thread(1) tag(0) DETAIL cip_encode_path:183 Done
Detail 2023-04-14 13:10:11.632 thread(1) tag(0) DETAIL session_create_unsafe:525 Setting connection_group_id to 0.
Detail 2023-04-14 13:10:11.633 thread(1) tag(0) DETAIL session_create_unsafe:565 Set maximum payload size to 508 bytes.
Detail 2023-04-14 13:10:11.633 thread(1) tag(0) DETAIL add_session_unsafe:333 Starting
Detail 2023-04-14 13:10:11.633 thread(1) tag(0) DETAIL add_session_unsafe:343 Done
Info 2023-04-14 13:10:11.633 thread(1) tag(0) INFO session_create_unsafe:582 Done
Info 2023-04-14 13:10:11.633 thread(1) tag(0) INFO session_init:598 Starting.
Detail 2023-04-14 13:10:11.633 thread(1) tag(0) DETAIL mutex_create:726 Starting.
Detail 2023-04-14 13:10:11.633 thread(1) tag(0) DETAIL mutex_create:753 Done.
Detail 2023-04-14 13:10:11.633 thread(1) tag(0) DETAIL cond_create:1087 Starting.
Detail 2023-04-14 13:10:11.634 thread(1) tag(0) DETAIL cond_create:1114 Done.
Detail 2023-04-14 13:10:11.634 thread(1) tag(0) DETAIL thread_create:884 Starting.
Detail 2023-04-14 13:10:11.634 thread(1) tag(0) DETAIL thread_create:917 Done.
Info 2023-04-14 13:10:11.634 thread(1) tag(0) INFO session_init:620 Done.
Detail 2023-04-14 13:10:11.634 thread(1) tag(0) DETAIL session_find_or_create:323 Done
Info 2023-04-14 13:10:11.634 thread(3) tag(0) INFO session_handler:1032 Starting thread for session 00000175CA3E2440
Detail 2023-04-14 13:10:11.634 thread(1) tag(0) DETAIL ab_tag_create:287 using session=00000175CA3E2440
Detail 2023-04-14 13:10:11.635 thread(1) tag(0) DETAIL get_tag_data_type:532 Starting.
Info 2023-04-14 13:10:11.635 thread(1) tag(0) INFO get_tag_data_type:645 Setting element size to 4.
Detail 2023-04-14 13:10:11.635 thread(1) tag(0) DETAIL get_tag_data_type:663 Done.
Detail 2023-04-14 13:10:11.635 thread(3) tag(0) DETAIL session_handler:1052 in SESSION_OPEN_SOCKET_START state.
Detail 2023-04-14 13:10:11.635 thread(1) tag(0) DETAIL ab_tag_create:381 Setting up Micro8X0 tag.
Detail 2023-04-14 13:10:11.635 thread(1) tag(0) DETAIL ab_tag_create:389 Using default Micro8x0 byte order.
Info 2023-04-14 13:10:11.635 thread(3) tag(0) INFO session_open_socket:638 Starting.
Detail 2023-04-14 13:10:11.635 thread(1) tag(0) DETAIL ab_tag_create:395 Setting default Logix vtable.
Detail 2023-04-14 13:10:11.636 thread(3) tag(0) DETAIL socket_create:1311 Starting.
Detail 2023-04-14 13:10:11.636 thread(1) tag(0) DETAIL parse_symbolic_segment:720 Starting with name index=0 and encoded name index=1.
Detail 2023-04-14 13:10:11.636 thread(1) tag(0) DETAIL parse_symbolic_segment:759 Parsed symbolic segment "Programs:SomeProgram" in tag name.
Detail 2023-04-14 13:10:11.636 thread(1) tag(0) DETAIL parse_symbolic_segment:720 Starting with name index=21 and encoded name index=23.
Detail 2023-04-14 13:10:11.637 thread(1) tag(0) DETAIL parse_symbolic_segment:759 Parsed symbolic segment "SomeDint" in tag name.
Detail 2023-04-14 13:10:11.637 thread(1) tag(0) DETAIL cip_encode_tag_name:622 Found symbolic segment ending at 29
Detail 2023-04-14 13:10:11.637 thread(3) tag(0) DETAIL socket_create:1334 Done.
Detail 2023-04-14 13:10:11.637 thread(1) tag(0) DETAIL ab_tag_create:500 Kicking off initial read.
Detail 2023-04-14 13:10:11.637 thread(3) tag(0) DETAIL session_open_socket:672 Using default port 44818.
Detail 2023-04-14 13:10:11.638 thread(3) tag(0) DETAIL socket_connect_tcp_start:1355 Starting.
Info 2023-04-14 13:10:11.637 thread(1) tag(0) INFO tag_read_start:307 Starting
Info 2023-04-14 13:10:11.638 thread(1) tag(0) INFO build_read_request_connected:418 Starting.
Detail 2023-04-14 13:10:11.638 thread(3) tag(0) DETAIL socket_connect_tcp_start:1404 Found numeric IP address: 192.168.100.199
Detail 2023-04-14 13:10:11.639 thread(3) tag(0) DETAIL socket_connect_tcp_start:1444 Setting up wake pipe.
Detail 2023-04-14 13:10:11.639 thread(1) tag(0) DETAIL session_create_request:2517 Starting.
Info 2023-04-14 13:10:11.639 thread(3) tag(0) INFO sock_create_event_wakeup_channel:2161 Starting.
Info 2023-04-14 13:10:11.640 thread(1) tag(0) INFO rc_alloc_impl:111 Starting, called from session_create_request:2526
Info 2023-04-14 13:10:11.640 thread(1) tag(0) INFO rc_alloc_impl:130 Done
Info 2023-04-14 13:10:11.640 thread(3) tag(0) INFO sock_create_event_wakeup_channel:2308 Done.
Detail 2023-04-14 13:10:11.643 thread(1) tag(0) DETAIL rc_alloc_impl:135 Returning memory pointer 00000175CA36CA70
Detail 2023-04-14 13:10:11.643 thread(1) tag(0) DETAIL session_create_request:2540 Done.
Info 2023-04-14 13:10:11.644 thread(1) tag(0) INFO session_add_request:960 Starting. sess=00000175CA3E2440, req=00000175CA36CA70
Detail 2023-04-14 13:10:11.643 thread(3) tag(0) DETAIL socket_connect_tcp_start:1475 Socket connection attempt 0 started successfully.
Detail 2023-04-14 13:10:11.644 thread(1) tag(0) DETAIL session_add_request_unsafe:925 Starting.
Detail 2023-04-14 13:10:11.644 thread(3) tag(0) DETAIL socket_connect_tcp_start:1501 Done.
Detail 2023-04-14 13:10:11.644 thread(1) tag(0) DETAIL session_add_request_unsafe:944 Total requests in the queue: 1
Info 2023-04-14 13:10:11.644 thread(3) tag(0) INFO session_open_socket:687 Done.
Detail 2023-04-14 13:10:11.645 thread(1) tag(0) DETAIL session_add_request_unsafe:946 Done.
Detail 2023-04-14 13:10:11.645 thread(3) tag(0) DETAIL session_handler:1068 Connect started, going to state SESSION_OPEN_SOCKET_WAIT.
Info 2023-04-14 13:10:11.645 thread(1) tag(0) INFO session_add_request:968 Done.
Detail 2023-04-14 13:10:11.646 thread(3) tag(0) DETAIL session_handler:1080 in SESSION_OPEN_SOCKET_WAIT state.
Info 2023-04-14 13:10:11.646 thread(1) tag(0) INFO build_read_request_connected:503 Done
Detail 2023-04-14 13:10:11.646 thread(3) tag(0) DETAIL socket_connect_tcp_check:1518 Starting.
Info 2023-04-14 13:10:11.646 thread(1) tag(0) INFO tag_read_start:336 Done.
Detail 2023-04-14 13:10:11.646 thread(3) tag(0) DETAIL socket_connect_tcp_check:1538 Socket is connected.
Detail 2023-04-14 13:10:11.647 thread(3) tag(0) DETAIL socket_connect_tcp_check:1598 Done.
Info 2023-04-14 13:10:11.647 thread(3) tag(0) INFO session_handler:1086 Socket connection succeeded.
Detail 2023-04-14 13:10:11.647 thread(3) tag(0) DETAIL session_handler:1107 in SESSION_REGISTER state.
Info 2023-04-14 13:10:11.648 thread(3) tag(0) INFO session_register:700 Starting.
Info 2023-04-14 13:10:11.648 thread(3) tag(0) INFO send_eip_request:1870 Starting.
Info 2023-04-14 13:10:11.648 thread(3) tag(0) INFO send_eip_request:1883 Sending packet of size 28
Detail 2023-04-14 13:10:11.647 thread(1) tag(0) DETAIL ab_tag_create:513 Using vtable 00007FFD55805120.
Info 2023-04-14 13:10:11.649 thread(3) tag(0) INFO send_eip_request:1884 00000 65 00 04 00 00 00 00 00 00 00 00 00 00 00 00 00
Info 2023-04-14 13:10:11.649 thread(1) tag(0) INFO ab_tag_create:515 Done.
Info 2023-04-14 13:10:11.649 thread(3) tag(0) INFO send_eip_request:1884 00016 00 00 00 00 00 00 00 00 01 00 00 00
Detail 2023-04-14 13:10:11.650 thread(3) tag(0) DETAIL socket_write:1945 Starting.
Info 2023-04-14 13:10:11.650 thread(1) tag(0) INFO set_tag_byte_order:3926 Starting.
Detail 2023-04-14 13:10:11.650 thread(3) tag(0) DETAIL socket_write:2072 Done: result = 28.
Info 2023-04-14 13:10:11.650 thread(3) tag(0) INFO send_eip_request:1926 Done.
Info 2023-04-14 13:10:11.650 thread(1) tag(0) INFO set_tag_byte_order:4227 Done.
Detail 2023-04-14 13:10:11.651 thread(1) tag(0) DETAIL add_tag_lookup:4330 Starting.
Info 2023-04-14 13:10:11.651 thread(3) tag(0) INFO recv_eip_response:1946 Starting.
Detail 2023-04-14 13:10:11.651 thread(3) tag(0) DETAIL socket_read:1807 Starting.
Detail 2023-04-14 13:10:11.651 thread(1) tag(0) DETAIL add_tag_lookup:4350 Found unused ID 11
Detail 2023-04-14 13:10:11.651 thread(3) tag(0) DETAIL socket_read:1934 Done: result = 24.
Detail 2023-04-14 13:10:11.651 thread(1) tag(0) DETAIL add_tag_lookup:4370 Done.
Detail 2023-04-14 13:10:11.652 thread(3) tag(0) DETAIL socket_read:1807 Starting.
Info 2023-04-14 13:10:11.652 thread(1) tag(11) INFO plc_tag_create_ex:973 Returning mapped tag ID 11
Detail 2023-04-14 13:10:11.652 thread(1) tag(11) DETAIL plc_tag_create_ex:999 Tag status after creation is PLCTAG_STATUS_PENDING.
Detail 2023-04-14 13:10:11.652 thread(1) tag(11) DETAIL plc_tag_tickler_wake_impl:220 Starting. Called from plc_tag_create_ex:1010.
Detail 2023-04-14 13:10:11.653 thread(1) tag(11) DETAIL plc_tag_tickler_wake_impl:233 Done. Called from plc_tag_create_ex:1010.
Detail 2023-04-14 13:10:11.653 thread(2) tag(11) DETAIL tag_tickler_func:550 Tickling tag 11.
Detail 2023-04-14 13:10:11.652 thread(3) tag(0) DETAIL socket_read:1934 Done: result = 4.
Detail 2023-04-14 13:10:11.654 thread(2) tag(11) DETAIL plc_tag_generic_tickler:281 Tickling tag 11.
Info 2023-04-14 13:10:11.654 thread(3) tag(0) INFO recv_eip_response:2017 request received all needed data (28 bytes of 28).
Detail 2023-04-14 13:10:11.655 thread(2) tag(11) DETAIL plc_tag_generic_tickler:386 Done.
Info 2023-04-14 13:10:11.655 thread(3) tag(0) INFO recv_eip_response:2019 00000 65 00 04 00 a9 87 3a 38 00 00 00 00 00 00 00 00
Detail 2023-04-14 13:10:11.655 thread(2) tag(0) DETAIL check_read_request_status:1106 Read not ready with status PLCTAG_STATUS_PENDING.
Info 2023-04-14 13:10:11.655 thread(3) tag(0) INFO recv_eip_response:2019 00016 00 00 00 00 00 00 00 00 01 00 00 00
Detail 2023-04-14 13:10:11.656 thread(2) tag(0) DETAIL check_read_status_connected:1345 Read request status is not OK.
Info 2023-04-14 13:10:11.656 thread(3) tag(0) INFO recv_eip_response:2026 Done.
Info 2023-04-14 13:10:11.656 thread(3) tag(0) INFO session_register:767 Done.
Detail 2023-04-14 13:10:11.657 thread(3) tag(0) DETAIL session_handler:1123 in SESSION_SEND_FORWARD_OPEN state.
Info 2023-04-14 13:10:11.657 thread(3) tag(0) INFO send_forward_open_request:2064 Starting
Detail 2023-04-14 13:10:11.657 thread(3) tag(0) DETAIL send_forward_open_request:2147 Set maximum payload size guess to 4002 bytes.
Info 2023-04-14 13:10:11.657 thread(3) tag(0) INFO send_extended_forward_open_request:2251 Starting
Info 2023-04-14 13:10:11.658 thread(3) tag(0) INFO send_eip_request:1870 Starting.
Info 2023-04-14 13:10:11.658 thread(3) tag(0) INFO send_eip_request:1883 Sending packet of size 90
Info 2023-04-14 13:10:11.658 thread(3) tag(0) INFO send_eip_request:1884 00000 6f 00 42 00 a9 87 3a 38 00 00 00 00 7b 0d 00 00
Info 2023-04-14 13:10:11.658 thread(3) tag(0) INFO send_eip_request:1884 00016 00 00 00 00 00 00 00 00 00 00 00 00 01 00 02 00
Info 2023-04-14 13:10:11.659 thread(3) tag(0) INFO send_eip_request:1884 00032 00 00 00 00 b2 00 32 00 5b 02 20 06 24 01 0a 05
Info 2023-04-14 13:10:11.659 thread(3) tag(0) INFO send_eip_request:1884 00048 00 00 00 00 76 33 00 00 ee 4c 3d f3 45 43 50 21
Info 2023-04-14 13:10:11.659 thread(3) tag(0) INFO send_eip_request:1884 00064 01 00 00 00 40 42 0f 00 a2 0f 00 42 40 42 0f 00
Info 2023-04-14 13:10:11.659 thread(3) tag(0) INFO send_eip_request:1884 00080 a2 0f 00 42 a3 02 20 02 24 01
Detail 2023-04-14 13:10:11.659 thread(3) tag(0) DETAIL socket_write:1945 Starting.
Detail 2023-04-14 13:10:11.660 thread(3) tag(0) DETAIL socket_write:2072 Done: result = 90.
Info 2023-04-14 13:10:11.660 thread(3) tag(0) INFO send_eip_request:1926 Done.
Info 2023-04-14 13:10:11.660 thread(3) tag(0) INFO send_extended_forward_open_request:2310 Done
Info 2023-04-14 13:10:11.660 thread(3) tag(0) INFO send_forward_open_request:2152 Done
Detail 2023-04-14 13:10:11.660 thread(3) tag(0) DETAIL session_handler:1129 Send Forward Open succeeded, going to SESSION_RECEIVE_FORWARD_OPEN state.
Detail 2023-04-14 13:10:11.661 thread(3) tag(0) DETAIL session_handler:1136 in SESSION_RECEIVE_FORWARD_OPEN state.
Info 2023-04-14 13:10:11.661 thread(3) tag(0) INFO receive_forward_open_response:2323 Starting
Info 2023-04-14 13:10:11.661 thread(3) tag(0) INFO recv_eip_response:1946 Starting.
Detail 2023-04-14 13:10:11.662 thread(3) tag(0) DETAIL socket_read:1807 Starting.
Detail 2023-04-14 13:10:11.662 thread(3) tag(0) DETAIL socket_read:1934 Done: result = 24.
Detail 2023-04-14 13:10:11.662 thread(3) tag(0) DETAIL socket_read:1807 Starting.
Detail 2023-04-14 13:10:11.662 thread(3) tag(0) DETAIL socket_read:1934 Done: result = 46.
Info 2023-04-14 13:10:11.662 thread(3) tag(0) INFO recv_eip_response:2017 request received all needed data (70 bytes of 70).
Info 2023-04-14 13:10:11.663 thread(3) tag(0) INFO recv_eip_response:2019 00000 6f 00 2e 00 a9 87 3a 38 00 00 00 00 7b 0d 00 00
Info 2023-04-14 13:10:11.663 thread(3) tag(0) INFO recv_eip_response:2019 00016 00 00 00 00 00 00 00 00 00 00 00 00 05 00 02 00
Info 2023-04-14 13:10:11.663 thread(3) tag(0) INFO recv_eip_response:2019 00032 00 00 00 00 b2 00 1e 00 db 00 00 00 44 bf 4a fa
Info 2023-04-14 13:10:11.663 thread(3) tag(0) INFO recv_eip_response:2019 00048 76 33 00 00 ee 4c 3d f3 45 43 50 21 40 42 0f 00
Info 2023-04-14 13:10:11.663 thread(3) tag(0) INFO recv_eip_response:2019 00064 40 42 0f 00 00 00
Info 2023-04-14 13:10:11.664 thread(3) tag(0) INFO recv_eip_response:2026 Done.
Info 2023-04-14 13:10:11.664 thread(3) tag(0) INFO receive_forward_open_response:2385 ForwardOpen succeeded with our connection ID 3376 and the PLC connection ID fa4abf44 w
ith packet size 4002.
Info 2023-04-14 13:10:11.664 thread(3) tag(0) INFO receive_forward_open_response:2390 Done.
Detail 2023-04-14 13:10:11.664 thread(3) tag(0) DETAIL session_handler:1155 Send Forward Open succeeded, going to SESSION_IDLE state.
Detail 2023-04-14 13:10:11.665 thread(3) tag(0) DETAIL session_handler:1162 in SESSION_IDLE state.
Detail 2023-04-14 13:10:11.665 thread(3) tag(0) DETAIL session_handler:1168 There are 1 requests pending before cleanup and sending.
Detail 2023-04-14 13:10:11.665 thread(3) tag(0) DETAIL get_payload_size:1673 Starting.
Detail 2023-04-14 13:10:11.665 thread(3) tag(0) DETAIL get_payload_size:1687 Done.
Info 2023-04-14 13:10:11.666 thread(3) tag(0) INFO process_requests:1444 1 requests to process.
Info 2023-04-14 13:10:11.666 thread(3) tag(0) INFO pack_requests:1708 Starting.
Info 2023-04-14 13:10:11.666 thread(3) tag(0) INFO pack_requests:1718 Only one request, so done.
Info 2023-04-14 13:10:11.666 thread(3) tag(0) INFO prepare_request:1810 Starting.
Detail 2023-04-14 13:10:11.667 thread(3) tag(0) DETAIL prepare_request:1839 cpf_targ_conn_id=fa4abf44
Info 2023-04-14 13:10:11.667 thread(3) tag(0) INFO prepare_request:1847 Preparing connected packet with connection ID 3376 and sequence ID 1(1)
Info 2023-04-14 13:10:11.667 thread(3) tag(0) INFO prepare_request:1854 Prepared packet of size 86
Info 2023-04-14 13:10:11.667 thread(3) tag(0) INFO prepare_request:1855 00000 70 00 3e 00 a9 87 3a 38 00 00 00 00 00 00 00 00
Info 2023-04-14 13:10:11.667 thread(3) tag(0) INFO prepare_request:1855 00016 00 00 00 00 00 00 00 00 00 00 00 00 01 00 02 00
Info 2023-04-14 13:10:11.668 thread(3) tag(0) INFO prepare_request:1855 00032 a1 00 04 00 44 bf 4a fa b1 00 2a 00 01 00 52 10
Info 2023-04-14 13:10:11.668 thread(3) tag(0) INFO prepare_request:1855 00048 91 14 50 72 6f 67 72 61 6d 73 3a 53 6f 6d 65 50
Info 2023-04-14 13:10:11.668 thread(3) tag(0) INFO prepare_request:1855 00064 72 6f 67 72 61 6d 91 08 53 6f 6d 65 44 69 6e 74
Info 2023-04-14 13:10:11.668 thread(3) tag(0) INFO prepare_request:1855 00080 01 00 00 00 00 00
Info 2023-04-14 13:10:11.669 thread(3) tag(0) INFO prepare_request:1857 Done.
Info 2023-04-14 13:10:11.670 thread(3) tag(0) INFO send_eip_request:1870 Starting.
Info 2023-04-14 13:10:11.670 thread(3) tag(0) INFO send_eip_request:1883 Sending packet of size 86
Info 2023-04-14 13:10:11.671 thread(3) tag(0) INFO send_eip_request:1884 00000 70 00 3e 00 a9 87 3a 38 00 00 00 00 00 00 00 00
Info 2023-04-14 13:10:11.671 thread(3) tag(0) INFO send_eip_request:1884 00016 00 00 00 00 00 00 00 00 00 00 00 00 01 00 02 00
Info 2023-04-14 13:10:11.671 thread(3) tag(0) INFO send_eip_request:1884 00032 a1 00 04 00 44 bf 4a fa b1 00 2a 00 01 00 52 10
Info 2023-04-14 13:10:11.672 thread(3) tag(0) INFO send_eip_request:1884 00048 91 14 50 72 6f 67 72 61 6d 73 3a 53 6f 6d 65 50
Info 2023-04-14 13:10:11.672 thread(3) tag(0) INFO send_eip_request:1884 00064 72 6f 67 72 61 6d 91 08 53 6f 6d 65 44 69 6e 74
Info 2023-04-14 13:10:11.673 thread(3) tag(0) INFO send_eip_request:1884 00080 01 00 00 00 00 00
Detail 2023-04-14 13:10:11.673 thread(3) tag(0) DETAIL socket_write:1945 Starting.
Detail 2023-04-14 13:10:11.674 thread(3) tag(0) DETAIL socket_write:2072 Done: result = 86.
Info 2023-04-14 13:10:11.675 thread(3) tag(0) INFO send_eip_request:1926 Done.
Info 2023-04-14 13:10:11.676 thread(3) tag(0) INFO recv_eip_response:1946 Starting.
Detail 2023-04-14 13:10:11.676 thread(3) tag(0) DETAIL socket_read:1807 Starting.
Detail 2023-04-14 13:10:11.676 thread(3) tag(0) DETAIL socket_read:1934 Done: result = 24.
Detail 2023-04-14 13:10:11.676 thread(3) tag(0) DETAIL socket_read:1807 Starting.
Detail 2023-04-14 13:10:11.677 thread(3) tag(0) DETAIL socket_read:1934 Done: result = 26.
Info 2023-04-14 13:10:11.677 thread(3) tag(0) INFO recv_eip_response:2017 request received all needed data (50 bytes of 50).
Info 2023-04-14 13:10:11.677 thread(3) tag(0) INFO recv_eip_response:2019 00000 70 00 1a 00 a9 87 3a 38 00 00 00 00 00 00 00 00
Info 2023-04-14 13:10:11.678 thread(3) tag(0) INFO recv_eip_response:2019 00016 00 00 00 00 00 00 00 00 00 00 00 00 00 00 02 00
Info 2023-04-14 13:10:11.678 thread(3) tag(0) INFO recv_eip_response:2019 00032 a1 00 04 00 76 33 00 00 b1 00 06 00 01 00 d2 00
Info 2023-04-14 13:10:11.678 thread(3) tag(0) INFO recv_eip_response:2019 00048 05 00
Info 2023-04-14 13:10:11.679 thread(3) tag(0) INFO recv_eip_response:2026 Done.
Info 2023-04-14 13:10:11.679 thread(3) tag(0) INFO unpack_response:1552 Starting.
Info 2023-04-14 13:10:11.679 thread(3) tag(0) INFO unpack_response:1561 Got single response packet. Copying 50 bytes unchanged.
Info 2023-04-14 13:10:11.679 thread(3) tag(0) INFO unpack_response:1650 Unpacked packet:
Info 2023-04-14 13:10:11.680 thread(3) tag(0) INFO unpack_response:1651 00000 70 00 1a 00 a9 87 3a 38 00 00 00 00 00 00 00 00
Info 2023-04-14 13:10:11.680 thread(3) tag(0) INFO unpack_response:1651 00016 00 00 00 00 00 00 00 00 00 00 00 00 00 00 02 00
Info 2023-04-14 13:10:11.680 thread(3) tag(0) INFO unpack_response:1651 00032 a1 00 04 00 76 33 00 00 b1 00 06 00 01 00 d2 00
Info 2023-04-14 13:10:11.680 thread(3) tag(0) INFO unpack_response:1651 00048 05 00
Detail 2023-04-14 13:10:11.681 thread(3) tag(0) DETAIL unpack_response:1660 Done.
Detail 2023-04-14 13:10:11.681 thread(3) tag(0) DETAIL plc_tag_tickler_wake_impl:220 Starting. Called from process_requests:1532.
Detail 2023-04-14 13:10:11.681 thread(3) tag(0) DETAIL plc_tag_tickler_wake_impl:233 Done. Called from process_requests:1532.
Detail 2023-04-14 13:10:11.681 thread(2) tag(11) DETAIL tag_tickler_func:550 Tickling tag 11.
Detail 2023-04-14 13:10:11.681 thread(2) tag(11) DETAIL plc_tag_generic_tickler:281 Tickling tag 11.
Detail 2023-04-14 13:10:11.682 thread(2) tag(11) DETAIL plc_tag_generic_tickler:386 Done.
Warn 2023-04-14 13:10:11.682 thread(2) tag(0) WARN check_read_status_connected:1392 CIP read failed with status: 0x5 Path Destination Error
Info 2023-04-14 13:10:11.682 thread(2) tag(0) INFO check_read_status_connected:1393 The Class, Instance or Attribute value specified in the Unconnected Explicit Message req
uest is incorrect or not supported in the Target device. Check the manufacturer's documentation for the correct codes to use.
Detail 2023-04-14 13:10:11.683 thread(2) tag(0) DETAIL rc_dec_impl:242 Calling cleanup functions due to call at check_read_status_connected:1504 for 00000175CA36CA70.
Info 2023-04-14 13:10:11.683 thread(2) tag(0) INFO refcount_cleanup:256 Starting
Detail 2023-04-14 13:10:11.683 thread(2) tag(0) DETAIL request_destroy:2559 Starting.
Detail 2023-04-14 13:10:11.683 thread(2) tag(0) DETAIL request_destroy:2568 Done.
Info 2023-04-14 13:10:11.684 thread(2) tag(0) INFO refcount_cleanup:268 Done.
Warn 2023-04-14 13:10:11.684 thread(2) tag(0) WARN check_read_status_connected:1531 Error received!
Detail 2023-04-14 13:10:11.684 thread(2) tag(0) DETAIL ab_tag_abort:732 Starting.
Detail 2023-04-14 13:10:11.684 thread(2) tag(0) DETAIL ab_tag_abort:741 Called without a request in flight.
Detail 2023-04-14 13:10:11.685 thread(2) tag(0) DETAIL ab_tag_abort:748 Done.
Detail 2023-04-14 13:10:11.685 thread(2) tag(0) DETAIL tag_raise_event:198 PLCTAG_EVENT_CREATED raised with status PLCTAG_ERR_BAD_PARAM.
Detail 2023-04-14 13:10:11.685 thread(2) tag(0) DETAIL tag_raise_event:215 PLCTAG_EVENT_READ_COMPLETED raised with status PLCTAG_ERR_BAD_PARAM.
Detail 2023-04-14 13:10:11.686 thread(2) tag(0) DETAIL plc_tag_tickler_wake_impl:220 Starting. Called from tag_tickler_func:569.
Detail 2023-04-14 13:10:11.686 thread(2) tag(0) DETAIL plc_tag_tickler_wake_impl:233 Done. Called from tag_tickler_func:569.
Detail 2023-04-14 13:10:11.686 thread(2) tag(11) DETAIL plc_tag_generic_handle_event_callbacks:402 Tag creation complete with status PLCTAG_ERR_BAD_PARAM.
Warn 2023-04-14 13:10:11.686 thread(1) tag(11) WARN plc_tag_create_ex:1047 Error PLCTAG_ERR_BAD_PARAM while trying to create tag!
Detail 2023-04-14 13:10:11.686 thread(1) tag(11) DETAIL ab_tag_abort:732 Starting.
Detail 2023-04-14 13:10:11.687 thread(1) tag(11) DETAIL ab_tag_abort:741 Called without a request in flight.
Detail 2023-04-14 13:10:11.690 thread(1) tag(11) DETAIL ab_tag_abort:748 Done.
Detail 2023-04-14 13:10:11.691 thread(1) tag(11) DETAIL hashtable_remove:232 Starting
Detail 2023-04-14 13:10:11.690 thread(2) tag(11) DETAIL tag_tickler_func:550 Tickling tag 11.
Detail 2023-04-14 13:10:11.691 thread(1) tag(11) DETAIL hashtable_remove:250 Done
Detail 2023-04-14 13:10:11.691 thread(2) tag(11) DETAIL plc_tag_generic_tickler:281 Tickling tag 11.
Detail 2023-04-14 13:10:11.691 thread(2) tag(11) DETAIL plc_tag_generic_tickler:386 Done.
Detail 2023-04-14 13:10:11.692 thread(2) tag(0) DETAIL rc_dec_impl:242 Calling cleanup functions due to call at tag_tickler_func:619 for 00000175CA37A950.
Info 2023-04-14 13:10:11.699 thread(2) tag(0) INFO refcount_cleanup:256 Starting
Info 2023-04-14 13:10:11.700 thread(2) tag(0) INFO ab_tag_destroy:800 Starting.
Detail 2023-04-14 13:10:11.700 thread(2) tag(0) DETAIL ab_tag_abort:732 Starting.
Detail 2023-04-14 13:10:11.708 thread(2) tag(0) DETAIL ab_tag_abort:741 Called without a request in flight.
Detail 2023-04-14 13:10:11.708 thread(2) tag(0) DETAIL ab_tag_abort:748 Done.
Detail 2023-04-14 13:10:11.708 thread(2) tag(0) DETAIL ab_tag_destroy:815 Getting ready to release tag session 00000175CA3E2440
Detail 2023-04-14 13:10:11.709 thread(2) tag(0) DETAIL ab_tag_destroy:817 Removing tag from session.
Detail 2023-04-14 13:10:11.778 thread(3) tag(0) DETAIL session_handler:1162 in SESSION_IDLE state.
Detail 2023-04-14 13:10:13.129 thread(3) tag(0) DETAIL session_handler:1162 in SESSION_IDLE state.
Detail 2023-04-14 13:10:13.096 thread(2) tag(0) DETAIL rc_dec_impl:242 Calling cleanup functions due to call at ab_tag_destroy:818 for 00000175CA3E2440.
Info 2023-04-14 13:10:13.129 thread(2) tag(0) INFO refcount_cleanup:256 Starting
Info 2023-04-14 13:10:13.129 thread(2) tag(0) INFO session_destroy:809 Starting.
Detail 2023-04-14 13:10:13.129 thread(2) tag(0) DETAIL remove_session:394 Starting.
Detail 2023-04-14 13:10:13.129 thread(2) tag(0) DETAIL remove_session_unsafe:370 Starting
Detail 2023-04-14 13:10:13.129 thread(2) tag(0) DETAIL remove_session_unsafe:385 Done
Detail 2023-04-14 13:10:13.129 thread(2) tag(0) DETAIL remove_session:402 Done.
Info 2023-04-14 13:10:13.130 thread(2) tag(0) INFO session_destroy:820 Session sent 3 packets.
Detail 2023-04-14 13:10:13.130 thread(2) tag(0) DETAIL session_destroy:831 Destroying session thread.
Detail 2023-04-14 13:10:13.130 thread(3) tag(0) DETAIL session_handler:1319 Critical block.
Info 2023-04-14 13:10:13.136 thread(2) tag(0) INFO perform_forward_close:2037 Starting.
Unhandled exception. Info 2023-04-14 13:10:14.963 thread(2) tag(0) INFO send_forward_close_req:2402 Starting
Detail 2023-04-14 13:10:14.963 thread(2) tag(0) DETAIL send_forward_close_req:2414 Forward Close connection path:
Detail 2023-04-14 13:10:14.964 thread(2) tag(0) DETAIL send_forward_close_req:2415 00000 20 02 24 01
Info 2023-04-14 13:10:14.964 thread(2) tag(0) INFO send_eip_request:1870 Starting.
Info 2023-04-14 13:10:14.964 thread(2) tag(0) INFO send_eip_request:1883 Sending packet of size 62
Info 2023-04-14 13:10:14.965 thread(2) tag(0) INFO send_eip_request:1884 00000 6f 00 26 00 a9 87 3a 38 00 00 00 00 7c 0d 00 00

msienkow commented

@fiddlydigit

I'm pretty sure that libplctag can't read program scoped tags from the Micro800 series. I know the same issue exists with the various python Ethernet/IP libraries. However you can read globally scoped tags from the Micro800. Also, when using with the Mico800, you have to comment out the Path parameter.

public static Tag Test()
{

    var myTag = new Tag()
    {
        Name = "SomeDint", // Globally scoped DINT tag
        // Path = "1,0",
        Gateway = "192.168.100.199",
        PlcType = PlcType.Micro800,
        Protocol = Protocol.ab_eip,
    
        //A global timeout value that is used for Initialize/Read/Write methods
        Timeout = TimeSpan.FromSeconds(1)
    };
    myTag.Initialize();
    return myTag;
}
  • 😕1
fiddlydigit commented

I have tried not including Path but I get BadParameter exception (I posted logs). So there is no way of getting variables or DI/DO?

msienkow commented

I have tried not including Path but I get BadParameter exception (I posted logs). So there is no way of getting variables or DI/DO?

You have to use globally scoped tags on the MicroLogix.

Untitled

fiddlydigit commented

@msienkow That was it🤦...Thanks!