Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

writing problem in omron nx1p2 PLC #434

Open
tly-seven opened this issue Aug 29, 2023 · 1 comment
Open

writing problem in omron nx1p2 PLC #434

tly-seven opened this issue Aug 29, 2023 · 1 comment
Labels
bug

Comments

@tly-seven
Copy link

tly-seven commented Aug 29, 2023 •
edited

Recently when using libplctag to connect to Omron nx1P2 PLC, I found a problem, when writing data to a byte-sized tag, it will report an error, but there is no problem to read the data, and there is no problem for other data types, see the attachment for the code and log file. Can anyone help take a look at this? Some help would be greatly appreciated!
@kyle-github @timmot @scontini76 @Joylei @alimon

code:
#include <unistd.h>
#include <signal.h>
#include <stdarg.h>
#include <stdio.h>
#include <stdlib.h>
#include <string.h>
#include "libplctag.h"

#define REQUIRED_VERSION 2,4,0
#define TAG_PATH_0 "protocol=ab_eip&gateway=192.168.250.1:44818&path=18,192.168.250.1&plc=omron-njnx&name=usint_t"
#define DATA_TIMEOUT 5000

int main(){

plc_tag_set_debug_level(2);

int32_t tag = 0;
char tag_string[256]={0};
char error_string[128]={0};
int rc = PLCTAG_STATUS_OK;
int tag_size = 0;
int e_size = 0;
int e_count = 0;
uint8_t ui8 =0;

/* create the tag. */
tag = plc_tag_create(TAG_PATH_0, DATA_TIMEOUT);

/* get the data */
rc = plc_tag_read(tag, DATA_TIMEOUT);


tag_size = plc_tag_get_int_attribute(tag, "size", 0);
e_size = plc_tag_get_int_attribute(tag, "elem_size", 0);
e_count = plc_tag_get_int_attribute(tag, "elem_count", 0);
ui8 = plc_tag_get_uint8(tag,0);
printf("elem_count : %d\n",e_count);
printf("elem_size : %d\n",e_size);
printf("tag_size : %d\n",tag_size);
printf("%u\n",ui8);
printf("0x%x\n",ui8);
printf(" ========================================= \n");



plc_tag_set_uint8(tag, 0, 7);


tag_size = plc_tag_get_int_attribute(tag, "size", 0);
e_size = plc_tag_get_int_attribute(tag, "elem_size", 0);
e_count = plc_tag_get_int_attribute(tag, "elem_count", 0);
ui8 = plc_tag_get_uint8(tag,0);
printf("elem_count : %d\n",e_count);
printf("elem_size : %d\n",e_size);
printf("tag_size : %d\n",tag_size);
printf("%u\n",ui8);
printf("0x%x\n",ui8);

rc = plc_tag_write(tag, DATA_TIMEOUT);
if(rc != PLCTAG_STATUS_OK) {
    sprintf(error_string,"ERROR:= Got error code %d: %s\n",rc, plc_tag_decode_error(rc));
    printf("%s\n",error_string);
    plc_tag_destroy(tag);

}

log
2023-08-29 14:43:16.796 thread(1) tag(0) INFO plc_tag_create_ex:838 Starting
2023-08-29 14:43:16.796 thread(1) tag(0) INFO initialize_modules:177 Starting.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO initialize_modules:186 Creating library mutex.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL mutex_create:648 Starting.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL mutex_create:677 Done creating mutex 0x55cd83262500.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO initialize_modules:207 Initializing library modules.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO lib_init:136 Starting.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO lib_init:140 Setting up global library data.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO lib_init:142 Creating tag hashtable.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO hashtable_create:75 Starting
2023-08-29 14:43:16.796 thread(1) tag(0) INFO hashtable_create:99 Done
2023-08-29 14:43:16.796 thread(1) tag(0) INFO lib_init:148 Creating tag hashtable mutex.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL mutex_create:648 Starting.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL mutex_create:677 Done creating mutex 0x55cd83263200.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO lib_init:154 Creating tag condition variable.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL cond_create:991 Starting.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL cond_create:1028 Done.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO lib_init:160 Creating tag tickler thread.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL thread_create:805 Starting.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL thread_create:807 Warning: ignoring stacksize (32768) parameter.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL thread_create:827 Done.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO lib_init:166 Done.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO initialize_modules:210 Initializing AB module.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO ab_init:123 Initializing AB protocol library.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL mutex_create:648 Starting.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL mutex_create:677 Done creating mutex 0x55cd83263400.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO ab_init:132 Finished initializing AB protocol library.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO initialize_modules:215 Initializing Modbus module.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO mb_init:2467 Starting.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL mb_init:2469 Setting up mutex.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL mutex_create:648 Starting.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL mutex_create:677 Done creating mutex 0x55cd83263460.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO mb_init:2478 Done.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO initialize_modules:226 Done initializing library modules.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO initialize_modules:231 Done.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL attr_create_from_str:129 Starting.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL attr_create_from_str:158 Key-value pair "protocol=ab_eip".
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL attr_create_from_str:173 Key-value pair before trimming "protocol":"ab_eip".
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL attr_create_from_str:185 Key-value pair after trimming "protocol":"ab_eip".
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL attr_create_from_str:158 Key-value pair "gateway=192.168.250.1:44818".
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL attr_create_from_str:173 Key-value pair before trimming "gateway":"192.168.250.1:44818".
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL attr_create_from_str:185 Key-value pair after trimming "gateway":"192.168.250.1:44818".
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL attr_create_from_str:158 Key-value pair "path=18,192.168.250.1".
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL attr_create_from_str:173 Key-value pair before trimming "path":"18,192.168.250.1".
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL attr_create_from_str:185 Key-value pair after trimming "path":"18,192.168.250.1".
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL attr_create_from_str:158 Key-value pair "plc=omron-njnx".
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL attr_create_from_str:173 Key-value pair before trimming "plc":"omron-njnx".
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL attr_create_from_str:185 Key-value pair after trimming "plc":"omron-njnx".
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL attr_create_from_str:158 Key-value pair "name=usint_t".
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL attr_create_from_str:173 Key-value pair before trimming "name":"usint_t".
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL attr_create_from_str:185 Key-value pair after trimming "name":"usint_t".
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL attr_create_from_str:216 Done.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO find_tag_create_func:99 Matched protocol=ab_eip
2023-08-29 14:43:16.796 thread(1) tag(0) INFO ab_tag_create:173 Starting.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO rc_alloc_impl:111 Starting, called from ab_tag_create:180
2023-08-29 14:43:16.796 thread(1) tag(0) INFO rc_alloc_impl:130 Done
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL rc_alloc_impl:135 Returning memory pointer 0x55cd83263980
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL ab_tag_create:186 tag=0x55cd83263980
2023-08-29 14:43:16.796 thread(1) tag(0) INFO plc_tag_generic_init_tag:467 Starting.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL mutex_create:648 Starting.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL mutex_create:677 Done creating mutex 0x55cd83263bb0.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL mutex_create:648 Starting.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL mutex_create:677 Done creating mutex 0x55cd83263bf0.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL cond_create:991 Starting.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL cond_create:1028 Done.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO plc_tag_generic_init_tag:498 Done.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL get_plc_type:937 Found OMRON NJ/NX Series PLC.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL get_plc_type:937 Found OMRON NJ/NX Series PLC.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL session_find_or_create:253 Starting
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL session_find_or_create:277 Creating new session.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO session_create_unsafe:469 Starting
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL session_create_unsafe:472 Session should use connected messaging.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO rc_alloc_impl:111 Starting, called from session_create_unsafe:477
2023-08-29 14:43:16.796 thread(1) tag(0) INFO rc_alloc_impl:130 Done
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL rc_alloc_impl:135 Returning memory pointer 0x55cd83263d20
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL cip_encode_path:71 Starting
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL match_numeric_segment:195 Starting at position 0 in string 18,192.168.250.1.
2023-08-29 14:43:16.796 thread(1) tag(0) WARN match_numeric_segment:210 Numeric segment in path at position 0 is out of bounds!
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL match_ip_addr_segment:248 Starting at position 0 in string 18,192.168.250.1.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL match_ip_addr_segment:263 Extended address on port A.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL match_ip_addr_segment:310 First IP segment: 192.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL match_ip_addr_segment:349 Second IP segment: 168.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL match_ip_addr_segment:388 Third IP segment: 250.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL match_ip_addr_segment:427 Fourth IP segment: 1.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL match_ip_addr_segment:444 Done.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL cip_encode_path:91 Found IP address segment.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL cip_encode_path:130 PLC needs connection, adding path to the router object.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL cip_encode_path:162 IOI size before 20
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL cip_encode_path:183 Done
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL session_create_unsafe:525 Setting connection_group_id to 0.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL session_create_unsafe:565 Set maximum payload size to 1996 bytes.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL add_session_unsafe:333 Starting
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL add_session_unsafe:343 Done
2023-08-29 14:43:16.796 thread(1) tag(0) INFO session_create_unsafe:582 Done
2023-08-29 14:43:16.796 thread(1) tag(0) INFO session_init:598 Starting.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL mutex_create:648 Starting.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL mutex_create:677 Done creating mutex 0x55cd83264e90.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL cond_create:991 Starting.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL cond_create:1028 Done.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL thread_create:805 Starting.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL thread_create:807 Warning: ignoring stacksize (32768) parameter.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL thread_create:827 Done.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO session_init:620 Done.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL session_find_or_create:323 Done
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL ab_tag_create:287 using session=0x55cd83263d20
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL get_tag_data_type:532 Starting.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL get_tag_data_type:663 Done.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL ab_tag_create:405 Setting up OMRON NJ/NX Series tag.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL ab_tag_create:415 Using default Omron byte order.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL ab_tag_create:421 Setting default Logix vtable.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL parse_symbolic_segment:720 Starting with name index=0 and encoded name index=1.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL parse_symbolic_segment:759 Parsed symbolic segment "usint_t" in tag name.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL ab_tag_create:500 Kicking off initial read.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO tag_read_start:307 Starting
2023-08-29 14:43:16.796 thread(1) tag(0) INFO build_read_request_connected:418 Starting.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL session_create_request:2517 Starting.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO rc_alloc_impl:111 Starting, called from session_create_request:2526
2023-08-29 14:43:16.796 thread(1) tag(0) INFO rc_alloc_impl:130 Done
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL rc_alloc_impl:135 Returning memory pointer 0x55cd832658b0
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL session_create_request:2540 Done.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO session_add_request:960 Starting. sess=0x55cd83263d20, req=0x55cd832658b0
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL session_add_request_unsafe:925 Starting.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL session_add_request_unsafe:944 Total requests in the queue: 1
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL session_add_request_unsafe:946 Done.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO session_add_request:968 Done.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO build_read_request_connected:503 Done
2023-08-29 14:43:16.796 thread(1) tag(0) INFO tag_read_start:336 Done.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL ab_tag_create:513 Using vtable 0x7f779b60d540.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO ab_tag_create:515 Done.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO set_tag_byte_order:3932 Starting.
2023-08-29 14:43:16.796 thread(1) tag(0) INFO set_tag_byte_order:4233 Done.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL add_tag_lookup:4336 Starting.
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL add_tag_lookup:4356 Found unused ID 11
2023-08-29 14:43:16.796 thread(1) tag(0) DETAIL add_tag_lookup:4376 Done.
2023-08-29 14:43:16.796 thread(1) tag(11) INFO plc_tag_create_ex:973 Returning mapped tag ID 11
2023-08-29 14:43:16.796 thread(1) tag(11) DETAIL plc_tag_create_ex:999 Tag status after creation is PLCTAG_STATUS_PENDING.
2023-08-29 14:43:16.796 thread(1) tag(11) DETAIL plc_tag_tickler_wake_impl:220 Starting. Called from plc_tag_create_ex:1010.
2023-08-29 14:43:16.796 thread(1) tag(11) DETAIL plc_tag_tickler_wake_impl:233 Done. Called from plc_tag_create_ex:1010.
2023-08-29 14:43:16.796 thread(2) tag(0) INFO session_handler:1032 Starting thread for session 0x55cd83263d20
2023-08-29 14:43:16.796 thread(2) tag(0) DETAIL session_handler:1052 in SESSION_OPEN_SOCKET_START state.
2023-08-29 14:43:16.796 thread(2) tag(0) INFO session_open_socket:638 Starting.
2023-08-29 14:43:16.796 thread(2) tag(0) DETAIL socket_create:1227 Starting.
2023-08-29 14:43:16.796 thread(2) tag(0) DETAIL socket_create:1245 Done.
2023-08-29 14:43:16.796 thread(2) tag(0) DETAIL session_open_socket:668 Using special port 44818.
2023-08-29 14:43:16.796 thread(2) tag(0) DETAIL socket_connect_tcp_start:1265 Starting.
2023-08-29 14:43:16.796 thread(3) tag(0) INFO tag_tickler_func:513 Starting.
2023-08-29 14:43:16.796 thread(3) tag(11) DETAIL tag_tickler_func:550 Tickling tag 11.
2023-08-29 14:43:16.796 thread(3) tag(11) DETAIL plc_tag_generic_tickler:281 Tickling tag 11.
2023-08-29 14:43:16.796 thread(3) tag(11) DETAIL plc_tag_generic_tickler:386 Done.
2023-08-29 14:43:16.796 thread(3) tag(0) DETAIL check_read_request_status:1106 Read not ready with status PLCTAG_STATUS_PENDING.
2023-08-29 14:43:16.796 thread(3) tag(0) DETAIL check_read_status_connected:1345 Read request status is not OK.
2023-08-29 14:43:16.796 thread(2) tag(0) DETAIL socket_connect_tcp_start:1340 Found numeric IP address: 192.168.250.1
2023-08-29 14:43:16.797 thread(2) tag(0) DETAIL socket_connect_tcp_start:1374 Setting up wake pipe.
2023-08-29 14:43:16.797 thread(2) tag(0) INFO sock_create_event_wakeup_channel:2087 Starting.
2023-08-29 14:43:16.796 thread(3) tag(11) DETAIL tag_tickler_func:550 Tickling tag 11.
2023-08-29 14:43:16.797 thread(3) tag(11) DETAIL plc_tag_generic_tickler:281 Tickling tag 11.
2023-08-29 14:43:16.797 thread(3) tag(11) DETAIL plc_tag_generic_tickler:386 Done.
2023-08-29 14:43:16.797 thread(2) tag(0) INFO sock_create_event_wakeup_channel:2204 Done.
2023-08-29 14:43:16.797 thread(2) tag(0) DETAIL socket_connect_tcp_start:1396 Attempting to connect to 192.168.250.1:44818
2023-08-29 14:43:16.797 thread(3) tag(0) DETAIL check_read_request_status:1106 Read not ready with status PLCTAG_STATUS_PENDING.
2023-08-29 14:43:16.797 thread(3) tag(0) DETAIL check_read_status_connected:1345 Read request status is not OK.
2023-08-29 14:43:16.797 thread(2) tag(0) DETAIL socket_connect_tcp_start:1410 Started connecting to 192.168.250.1:44818 successfully.
2023-08-29 14:43:16.797 thread(2) tag(0) DETAIL socket_connect_tcp_start:1431 Done with status PLCTAG_STATUS_PENDING.
2023-08-29 14:43:16.797 thread(2) tag(0) INFO session_open_socket:687 Done.
2023-08-29 14:43:16.797 thread(2) tag(0) DETAIL session_handler:1068 Connect started, going to state SESSION_OPEN_SOCKET_WAIT.
2023-08-29 14:43:16.797 thread(2) tag(0) DETAIL session_handler:1080 in SESSION_OPEN_SOCKET_WAIT state.
2023-08-29 14:43:16.797 thread(2) tag(0) DETAIL socket_connect_tcp_check:1448 Starting.
2023-08-29 14:43:16.800 thread(2) tag(0) DETAIL socket_connect_tcp_check:1467 Socket is probably connected.
2023-08-29 14:43:16.800 thread(2) tag(0) DETAIL socket_connect_tcp_check:1513 No error, socket is connected.
2023-08-29 14:43:16.800 thread(2) tag(0) DETAIL socket_connect_tcp_check:1557 Done.
2023-08-29 14:43:16.800 thread(2) tag(0) INFO session_handler:1086 Socket connection succeeded.
2023-08-29 14:43:16.800 thread(2) tag(0) DETAIL session_handler:1107 in SESSION_REGISTER state.
2023-08-29 14:43:16.800 thread(2) tag(0) INFO session_register:700 Starting.
2023-08-29 14:43:16.800 thread(2) tag(0) INFO send_eip_request:1870 Starting.
2023-08-29 14:43:16.800 thread(2) tag(0) INFO send_eip_request:1883 Sending packet of size 28
2023-08-29 14:43:16.800 thread(2) tag(0) INFO send_eip_request:1884 00000 65 00 04 00 00 00 00 00 00 00 00 00 00 00 00 00
2023-08-29 14:43:16.800 thread(2) tag(0) INFO send_eip_request:1884 00016 00 00 00 00 00 00 00 00 01 00 00 00
2023-08-29 14:43:16.800 thread(2) tag(0) DETAIL socket_write:1877 Starting.
2023-08-29 14:43:16.800 thread(2) tag(0) DETAIL socket_write:1999 Done: result = 28.
2023-08-29 14:43:16.800 thread(2) tag(0) INFO send_eip_request:1926 Done.
2023-08-29 14:43:16.800 thread(2) tag(0) INFO recv_eip_response:1946 Starting.
2023-08-29 14:43:16.800 thread(2) tag(0) DETAIL socket_read:1754 Starting.
2023-08-29 14:43:16.800 thread(2) tag(0) DETAIL socket_read:1786 Immediate read attempt did not succeed, now wait for select().
2023-08-29 14:43:16.804 thread(2) tag(0) DETAIL socket_read:1814 Socket can read data.
2023-08-29 14:43:16.804 thread(2) tag(0) DETAIL socket_read:1866 Done: result 24.
2023-08-29 14:43:16.804 thread(2) tag(0) DETAIL socket_read:1754 Starting.
2023-08-29 14:43:16.804 thread(2) tag(0) DETAIL socket_read:1866 Done: result 4.
2023-08-29 14:43:16.804 thread(2) tag(0) INFO recv_eip_response:2017 request received all needed data (28 bytes of 28).
2023-08-29 14:43:16.804 thread(2) tag(0) INFO recv_eip_response:2019 00000 65 00 04 00 71 01 26 00 00 00 00 00 00 00 00 00
2023-08-29 14:43:16.804 thread(2) tag(0) INFO recv_eip_response:2019 00016 00 00 00 00 00 00 00 00 01 00 00 00
2023-08-29 14:43:16.804 thread(2) tag(0) INFO recv_eip_response:2026 Done.
2023-08-29 14:43:16.804 thread(2) tag(0) INFO session_register:767 Done.
2023-08-29 14:43:16.804 thread(2) tag(0) DETAIL session_handler:1123 in SESSION_SEND_FORWARD_OPEN state.
2023-08-29 14:43:16.804 thread(2) tag(0) INFO send_forward_open_request:2064 Starting
2023-08-29 14:43:16.804 thread(2) tag(0) DETAIL send_forward_open_request:2147 Set maximum payload size guess to 1996 bytes.
2023-08-29 14:43:16.804 thread(2) tag(0) INFO send_extended_forward_open_request:2251 Starting
2023-08-29 14:43:16.804 thread(2) tag(0) INFO send_eip_request:1870 Starting.
2023-08-29 14:43:16.804 thread(2) tag(0) INFO send_eip_request:1883 Sending packet of size 106
2023-08-29 14:43:16.804 thread(2) tag(0) INFO send_eip_request:1884 00000 6f 00 52 00 71 01 26 00 00 00 00 00 86 16 da 09
2023-08-29 14:43:16.804 thread(2) tag(0) INFO send_eip_request:1884 00016 00 00 00 00 00 00 00 00 00 00 00 00 01 00 02 00
2023-08-29 14:43:16.804 thread(2) tag(0) INFO send_eip_request:1884 00032 00 00 00 00 b2 00 42 00 5b 02 20 06 24 01 0a 05
2023-08-29 14:43:16.804 thread(2) tag(0) INFO send_eip_request:1884 00048 00 00 00 00 a3 6d 57 75 cb 1a 3d f3 45 43 50 21
2023-08-29 14:43:16.804 thread(2) tag(0) INFO send_eip_request:1884 00064 01 00 00 00 40 42 0f 00 cc 07 00 42 40 42 0f 00
2023-08-29 14:43:16.804 thread(2) tag(0) INFO send_eip_request:1884 00080 cc 07 00 42 a3 0a 12 0d 31 39 32 2e 31 36 38 2e
2023-08-29 14:43:16.804 thread(2) tag(0) INFO send_eip_request:1884 00096 32 35 30 2e 31 00 20 02 24 01
2023-08-29 14:43:16.804 thread(2) tag(0) DETAIL socket_write:1877 Starting.
2023-08-29 14:43:16.804 thread(2) tag(0) DETAIL socket_write:1999 Done: result = 106.
2023-08-29 14:43:16.804 thread(2) tag(0) INFO send_eip_request:1926 Done.
2023-08-29 14:43:16.804 thread(2) tag(0) INFO send_extended_forward_open_request:2310 Done
2023-08-29 14:43:16.804 thread(2) tag(0) INFO send_forward_open_request:2152 Done
2023-08-29 14:43:16.804 thread(2) tag(0) DETAIL session_handler:1129 Send Forward Open succeeded, going to SESSION_RECEIVE_FORWARD_OPEN state.
2023-08-29 14:43:16.804 thread(2) tag(0) DETAIL session_handler:1136 in SESSION_RECEIVE_FORWARD_OPEN state.
2023-08-29 14:43:16.804 thread(2) tag(0) INFO receive_forward_open_response:2323 Starting
2023-08-29 14:43:16.804 thread(2) tag(0) INFO recv_eip_response:1946 Starting.
2023-08-29 14:43:16.804 thread(2) tag(0) DETAIL socket_read:1754 Starting.
2023-08-29 14:43:16.804 thread(2) tag(0) DETAIL socket_read:1786 Immediate read attempt did not succeed, now wait for select().
2023-08-29 14:43:16.810 thread(2) tag(0) DETAIL socket_read:1814 Socket can read data.
2023-08-29 14:43:16.810 thread(2) tag(0) DETAIL socket_read:1866 Done: result 24.
2023-08-29 14:43:16.810 thread(2) tag(0) DETAIL socket_read:1754 Starting.
2023-08-29 14:43:16.810 thread(2) tag(0) DETAIL socket_read:1866 Done: result 46.
2023-08-29 14:43:16.810 thread(2) tag(0) INFO recv_eip_response:2017 request received all needed data (70 bytes of 70).
2023-08-29 14:43:16.810 thread(2) tag(0) INFO recv_eip_response:2019 00000 6f 00 2e 00 71 01 26 00 00 00 00 00 86 16 da 09
2023-08-29 14:43:16.810 thread(2) tag(0) INFO recv_eip_response:2019 00016 00 00 00 00 00 00 00 00 00 00 00 00 01 00 02 00
2023-08-29 14:43:16.810 thread(2) tag(0) INFO recv_eip_response:2019 00032 00 00 00 00 b2 00 1e 00 db 00 00 00 41 13 f9 43
2023-08-29 14:43:16.810 thread(2) tag(0) INFO recv_eip_response:2019 00048 a3 6d 57 75 cb 1a 3d f3 45 43 50 21 40 42 0f 00
2023-08-29 14:43:16.810 thread(2) tag(0) INFO recv_eip_response:2019 00064 40 42 0f 00 00 00
2023-08-29 14:43:16.810 thread(2) tag(0) INFO recv_eip_response:2026 Done.
2023-08-29 14:43:16.810 thread(2) tag(0) INFO receive_forward_open_response:2385 ForwardOpen succeeded with our connection ID 75576da3 and the PLC connection ID 43f91341 with packet size 1996.
2023-08-29 14:43:16.810 thread(2) tag(0) INFO receive_forward_open_response:2390 Done.
2023-08-29 14:43:16.810 thread(2) tag(0) DETAIL session_handler:1155 Send Forward Open succeeded, going to SESSION_IDLE state.
2023-08-29 14:43:16.810 thread(2) tag(0) DETAIL session_handler:1162 in SESSION_IDLE state.
2023-08-29 14:43:16.810 thread(2) tag(0) DETAIL session_handler:1168 There are 1 requests pending before cleanup and sending.
2023-08-29 14:43:16.810 thread(2) tag(0) DETAIL get_payload_size:1673 Starting.
2023-08-29 14:43:16.810 thread(2) tag(0) DETAIL get_payload_size:1687 Done.
2023-08-29 14:43:16.810 thread(2) tag(0) INFO process_requests:1444 1 requests to process.
2023-08-29 14:43:16.810 thread(2) tag(0) INFO pack_requests:1708 Starting.
2023-08-29 14:43:16.810 thread(2) tag(0) INFO pack_requests:1718 Only one request, so done.
2023-08-29 14:43:16.810 thread(2) tag(0) INFO prepare_request:1810 Starting.
2023-08-29 14:43:16.810 thread(2) tag(0) DETAIL prepare_request:1839 cpf_targ_conn_id=43f91341
2023-08-29 14:43:16.810 thread(2) tag(0) INFO prepare_request:1847 Preparing connected packet with connection ID 75576da3 and sequence ID 1(1)
2023-08-29 14:43:16.810 thread(2) tag(0) INFO prepare_request:1854 Prepared packet of size 60
2023-08-29 14:43:16.810 thread(2) tag(0) INFO prepare_request:1855 00000 70 00 24 00 71 01 26 00 00 00 00 00 00 00 00 00
2023-08-29 14:43:16.810 thread(2) tag(0) INFO prepare_request:1855 00016 00 00 00 00 00 00 00 00 00 00 00 00 01 00 02 00
2023-08-29 14:43:16.811 thread(2) tag(0) INFO prepare_request:1855 00032 a1 00 04 00 41 13 f9 43 b1 00 10 00 01 00 4c 05
2023-08-29 14:43:16.811 thread(2) tag(0) INFO prepare_request:1855 00048 91 07 75 73 69 6e 74 5f 74 00 01 00
2023-08-29 14:43:16.811 thread(2) tag(0) INFO prepare_request:1857 Done.
2023-08-29 14:43:16.811 thread(2) tag(0) INFO send_eip_request:1870 Starting.
2023-08-29 14:43:16.811 thread(2) tag(0) INFO send_eip_request:1883 Sending packet of size 60
2023-08-29 14:43:16.811 thread(2) tag(0) INFO send_eip_request:1884 00000 70 00 24 00 71 01 26 00 00 00 00 00 00 00 00 00
2023-08-29 14:43:16.811 thread(2) tag(0) INFO send_eip_request:1884 00016 00 00 00 00 00 00 00 00 00 00 00 00 01 00 02 00
2023-08-29 14:43:16.811 thread(2) tag(0) INFO send_eip_request:1884 00032 a1 00 04 00 41 13 f9 43 b1 00 10 00 01 00 4c 05
2023-08-29 14:43:16.811 thread(2) tag(0) INFO send_eip_request:1884 00048 91 07 75 73 69 6e 74 5f 74 00 01 00
2023-08-29 14:43:16.811 thread(2) tag(0) DETAIL socket_write:1877 Starting.
2023-08-29 14:43:16.811 thread(2) tag(0) DETAIL socket_write:1999 Done: result = 60.
2023-08-29 14:43:16.811 thread(2) tag(0) INFO send_eip_request:1926 Done.
2023-08-29 14:43:16.811 thread(2) tag(0) INFO recv_eip_response:1946 Starting.
2023-08-29 14:43:16.811 thread(2) tag(0) DETAIL socket_read:1754 Starting.
2023-08-29 14:43:16.811 thread(2) tag(0) DETAIL socket_read:1786 Immediate read attempt did not succeed, now wait for select().
2023-08-29 14:43:16.814 thread(2) tag(0) DETAIL socket_read:1814 Socket can read data.
2023-08-29 14:43:16.814 thread(2) tag(0) DETAIL socket_read:1866 Done: result 24.
2023-08-29 14:43:16.814 thread(2) tag(0) DETAIL socket_read:1754 Starting.
2023-08-29 14:43:16.814 thread(2) tag(0) DETAIL socket_read:1866 Done: result 29.
2023-08-29 14:43:16.814 thread(2) tag(0) INFO recv_eip_response:2017 request received all needed data (53 bytes of 53).
2023-08-29 14:43:16.814 thread(2) tag(0) INFO recv_eip_response:2019 00000 70 00 1d 00 71 01 26 00 00 00 00 00 00 00 00 00
2023-08-29 14:43:16.814 thread(2) tag(0) INFO recv_eip_response:2019 00016 00 00 00 00 00 00 00 00 00 00 00 00 00 00 02 00
2023-08-29 14:43:16.814 thread(2) tag(0) INFO recv_eip_response:2019 00032 a1 00 04 00 a3 6d 57 75 b1 00 09 00 01 00 cc 00
2023-08-29 14:43:16.814 thread(2) tag(0) INFO recv_eip_response:2019 00048 00 00 c6 00 ff
2023-08-29 14:43:16.814 thread(2) tag(0) INFO recv_eip_response:2026 Done.
2023-08-29 14:43:16.814 thread(2) tag(0) INFO unpack_response:1552 Starting.
2023-08-29 14:43:16.814 thread(2) tag(0) INFO unpack_response:1561 Got single response packet. Copying 53 bytes unchanged.
2023-08-29 14:43:16.814 thread(2) tag(0) INFO unpack_response:1650 Unpacked packet:
2023-08-29 14:43:16.814 thread(2) tag(0) INFO unpack_response:1651 00000 70 00 1d 00 71 01 26 00 00 00 00 00 00 00 00 00
2023-08-29 14:43:16.814 thread(2) tag(0) INFO unpack_response:1651 00016 00 00 00 00 00 00 00 00 00 00 00 00 00 00 02 00
2023-08-29 14:43:16.814 thread(2) tag(0) INFO unpack_response:1651 00032 a1 00 04 00 a3 6d 57 75 b1 00 09 00 01 00 cc 00
2023-08-29 14:43:16.814 thread(2) tag(0) INFO unpack_response:1651 00048 00 00 c6 00 ff
2023-08-29 14:43:16.814 thread(2) tag(0) DETAIL unpack_response:1660 Done.
2023-08-29 14:43:16.814 thread(2) tag(0) DETAIL plc_tag_tickler_wake_impl:220 Starting. Called from process_requests:1532.
2023-08-29 14:43:16.814 thread(2) tag(0) DETAIL plc_tag_tickler_wake_impl:233 Done. Called from process_requests:1532.
2023-08-29 14:43:16.814 thread(3) tag(11) DETAIL tag_tickler_func:550 Tickling tag 11.
2023-08-29 14:43:16.814 thread(3) tag(11) DETAIL plc_tag_generic_tickler:281 Tickling tag 11.
2023-08-29 14:43:16.814 thread(3) tag(11) DETAIL plc_tag_generic_tickler:386 Done.
2023-08-29 14:43:16.814 thread(3) tag(0) DETAIL check_read_status_connected:1410 type byte = 198 (c6)
2023-08-29 14:43:16.814 thread(3) tag(0) DETAIL check_read_status_connected:1461 Increasing tag buffer size to 1 bytes.
2023-08-29 14:43:16.814 thread(3) tag(0) INFO check_read_status_connected:1471 Got 1 bytes of data
2023-08-29 14:43:16.814 thread(3) tag(0) DETAIL rc_dec_impl:242 Calling cleanup functions due to call at check_read_status_connected:1504 for 0x55cd832658b0.
2023-08-29 14:43:16.814 thread(3) tag(0) INFO refcount_cleanup:256 Starting
2023-08-29 14:43:16.814 thread(3) tag(0) DETAIL request_destroy:2559 Starting.
2023-08-29 14:43:16.814 thread(3) tag(0) DETAIL request_destroy:2568 Done.
2023-08-29 14:43:16.814 thread(3) tag(0) INFO refcount_cleanup:268 Done.
2023-08-29 14:43:16.814 thread(3) tag(0) DETAIL plc_tag_tickler_wake_impl:220 Starting. Called from tag_tickler_func:569.
2023-08-29 14:43:16.814 thread(3) tag(0) DETAIL plc_tag_tickler_wake_impl:233 Done. Called from tag_tickler_func:569.
2023-08-29 14:43:16.814 thread(3) tag(11) DETAIL tag_tickler_func:550 Tickling tag 11.
2023-08-29 14:43:16.814 thread(3) tag(11) DETAIL plc_tag_generic_tickler:281 Tickling tag 11.
2023-08-29 14:43:16.814 thread(3) tag(11) DETAIL plc_tag_generic_tickler:386 Done.
2023-08-29 14:43:16.814 thread(1) tag(11) INFO plc_tag_create_ex:1069 tag set up elapsed time 18ms
2023-08-29 14:43:16.814 thread(1) tag(11) INFO plc_tag_create_ex:1075 Done.
2023-08-29 14:43:16.814 thread(1) tag(11) INFO plc_tag_read:1607 Starting.
2023-08-29 14:43:16.814 thread(1) tag(11) INFO tag_read_start:307 Starting
2023-08-29 14:43:16.814 thread(1) tag(11) INFO build_read_request_connected:418 Starting.
2023-08-29 14:43:16.814 thread(1) tag(11) DETAIL session_create_request:2517 Starting.
2023-08-29 14:43:16.814 thread(1) tag(11) INFO rc_alloc_impl:111 Starting, called from session_create_request:2526
2023-08-29 14:43:16.814 thread(1) tag(11) INFO rc_alloc_impl:130 Done
2023-08-29 14:43:16.814 thread(1) tag(11) DETAIL rc_alloc_impl:135 Returning memory pointer 0x55cd83263780
2023-08-29 14:43:16.814 thread(1) tag(11) DETAIL session_create_request:2540 Done.
2023-08-29 14:43:16.814 thread(1) tag(11) INFO session_add_request:960 Starting. sess=0x55cd83263d20, req=0x55cd83263780
2023-08-29 14:43:16.814 thread(1) tag(11) DETAIL session_add_request_unsafe:925 Starting.
2023-08-29 14:43:16.814 thread(1) tag(11) DETAIL session_add_request_unsafe:944 Total requests in the queue: 1
2023-08-29 14:43:16.814 thread(1) tag(11) DETAIL session_add_request_unsafe:946 Done.
2023-08-29 14:43:16.814 thread(1) tag(11) INFO session_add_request:968 Done.
2023-08-29 14:43:16.814 thread(1) tag(11) INFO build_read_request_connected:503 Done
2023-08-29 14:43:16.814 thread(1) tag(11) INFO tag_read_start:336 Done.
2023-08-29 14:43:16.814 thread(1) tag(11) DETAIL plc_tag_tickler_wake_impl:220 Starting. Called from plc_tag_read:1682.
2023-08-29 14:43:16.814 thread(1) tag(11) DETAIL plc_tag_tickler_wake_impl:233 Done. Called from plc_tag_read:1682.
2023-08-29 14:43:16.814 thread(3) tag(11) DETAIL tag_tickler_func:550 Tickling tag 11.
2023-08-29 14:43:16.814 thread(3) tag(11) DETAIL plc_tag_generic_tickler:281 Tickling tag 11.
2023-08-29 14:43:16.814 thread(3) tag(11) DETAIL plc_tag_generic_tickler:386 Done.
2023-08-29 14:43:16.814 thread(3) tag(0) DETAIL check_read_request_status:1106 Read not ready with status PLCTAG_STATUS_PENDING.
2023-08-29 14:43:16.814 thread(3) tag(0) DETAIL check_read_status_connected:1345 Read request status is not OK.
2023-08-29 14:43:16.814 thread(2) tag(0) DETAIL session_handler:1162 in SESSION_IDLE state.
2023-08-29 14:43:16.814 thread(2) tag(0) DETAIL session_handler:1168 There are 1 requests pending before cleanup and sending.
2023-08-29 14:43:16.814 thread(2) tag(0) DETAIL get_payload_size:1673 Starting.
2023-08-29 14:43:16.814 thread(2) tag(0) DETAIL get_payload_size:1687 Done.
2023-08-29 14:43:16.814 thread(2) tag(0) INFO process_requests:1444 1 requests to process.
2023-08-29 14:43:16.814 thread(2) tag(0) INFO pack_requests:1708 Starting.
2023-08-29 14:43:16.814 thread(2) tag(11) INFO pack_requests:1718 Only one request, so done.
2023-08-29 14:43:16.814 thread(2) tag(0) INFO prepare_request:1810 Starting.
2023-08-29 14:43:16.814 thread(2) tag(0) DETAIL prepare_request:1839 cpf_targ_conn_id=43f91341
2023-08-29 14:43:16.814 thread(2) tag(0) INFO prepare_request:1847 Preparing connected packet with connection ID 75576da3 and sequence ID 2(2)
2023-08-29 14:43:16.815 thread(2) tag(0) INFO prepare_request:1854 Prepared packet of size 60
2023-08-29 14:43:16.815 thread(2) tag(0) INFO prepare_request:1855 00000 70 00 24 00 71 01 26 00 00 00 00 00 00 00 00 00
2023-08-29 14:43:16.815 thread(2) tag(0) INFO prepare_request:1855 00016 00 00 00 00 00 00 00 00 00 00 00 00 01 00 02 00
2023-08-29 14:43:16.815 thread(2) tag(0) INFO prepare_request:1855 00032 a1 00 04 00 41 13 f9 43 b1 00 10 00 02 00 4c 05
2023-08-29 14:43:16.815 thread(2) tag(0) INFO prepare_request:1855 00048 91 07 75 73 69 6e 74 5f 74 00 01 00
2023-08-29 14:43:16.815 thread(2) tag(0) INFO prepare_request:1857 Done.
2023-08-29 14:43:16.815 thread(2) tag(0) INFO send_eip_request:1870 Starting.
2023-08-29 14:43:16.815 thread(2) tag(0) INFO send_eip_request:1883 Sending packet of size 60
2023-08-29 14:43:16.815 thread(2) tag(0) INFO send_eip_request:1884 00000 70 00 24 00 71 01 26 00 00 00 00 00 00 00 00 00
2023-08-29 14:43:16.815 thread(2) tag(0) INFO send_eip_request:1884 00016 00 00 00 00 00 00 00 00 00 00 00 00 01 00 02 00
2023-08-29 14:43:16.815 thread(2) tag(0) INFO send_eip_request:1884 00032 a1 00 04 00 41 13 f9 43 b1 00 10 00 02 00 4c 05
2023-08-29 14:43:16.815 thread(2) tag(0) INFO send_eip_request:1884 00048 91 07 75 73 69 6e 74 5f 74 00 01 00
2023-08-29 14:43:16.815 thread(2) tag(0) DETAIL socket_write:1877 Starting.
2023-08-29 14:43:16.815 thread(2) tag(0) DETAIL socket_write:1999 Done: result = 60.
2023-08-29 14:43:16.815 thread(2) tag(0) INFO send_eip_request:1926 Done.
2023-08-29 14:43:16.815 thread(2) tag(0) INFO recv_eip_response:1946 Starting.
2023-08-29 14:43:16.815 thread(2) tag(0) DETAIL socket_read:1754 Starting.
2023-08-29 14:43:16.815 thread(2) tag(0) DETAIL socket_read:1786 Immediate read attempt did not succeed, now wait for select().
2023-08-29 14:43:16.818 thread(2) tag(0) DETAIL socket_read:1814 Socket can read data.
2023-08-29 14:43:16.818 thread(2) tag(0) DETAIL socket_read:1866 Done: result 24.
2023-08-29 14:43:16.818 thread(2) tag(0) DETAIL socket_read:1754 Starting.
2023-08-29 14:43:16.818 thread(2) tag(0) DETAIL socket_read:1866 Done: result 29.
2023-08-29 14:43:16.818 thread(2) tag(0) INFO recv_eip_response:2017 request received all needed data (53 bytes of 53).
2023-08-29 14:43:16.818 thread(2) tag(0) INFO recv_eip_response:2019 00000 70 00 1d 00 71 01 26 00 00 00 00 00 00 00 00 00
2023-08-29 14:43:16.818 thread(2) tag(0) INFO recv_eip_response:2019 00016 00 00 00 00 00 00 00 00 00 00 00 00 00 00 02 00
2023-08-29 14:43:16.818 thread(2) tag(0) INFO recv_eip_response:2019 00032 a1 00 04 00 a3 6d 57 75 b1 00 09 00 02 00 cc 00
2023-08-29 14:43:16.818 thread(2) tag(0) INFO recv_eip_response:2019 00048 00 00 c6 00 ff
2023-08-29 14:43:16.818 thread(2) tag(0) INFO recv_eip_response:2026 Done.
2023-08-29 14:43:16.818 thread(2) tag(11) INFO unpack_response:1552 Starting.
2023-08-29 14:43:16.818 thread(2) tag(11) INFO unpack_response:1561 Got single response packet. Copying 53 bytes unchanged.
2023-08-29 14:43:16.818 thread(2) tag(11) INFO unpack_response:1650 Unpacked packet:
2023-08-29 14:43:16.818 thread(2) tag(11) INFO unpack_response:1651 00000 70 00 1d 00 71 01 26 00 00 00 00 00 00 00 00 00
2023-08-29 14:43:16.818 thread(2) tag(11) INFO unpack_response:1651 00016 00 00 00 00 00 00 00 00 00 00 00 00 00 00 02 00
2023-08-29 14:43:16.818 thread(2) tag(11) INFO unpack_response:1651 00032 a1 00 04 00 a3 6d 57 75 b1 00 09 00 02 00 cc 00
2023-08-29 14:43:16.818 thread(2) tag(11) INFO unpack_response:1651 00048 00 00 c6 00 ff
2023-08-29 14:43:16.818 thread(2) tag(11) DETAIL unpack_response:1660 Done.
2023-08-29 14:43:16.818 thread(2) tag(11) DETAIL plc_tag_tickler_wake_impl:220 Starting. Called from process_requests:1532.
2023-08-29 14:43:16.818 thread(2) tag(11) DETAIL plc_tag_tickler_wake_impl:233 Done. Called from process_requests:1532.
2023-08-29 14:43:16.818 thread(3) tag(11) DETAIL tag_tickler_func:550 Tickling tag 11.
2023-08-29 14:43:16.818 thread(3) tag(11) DETAIL plc_tag_generic_tickler:281 Tickling tag 11.
2023-08-29 14:43:16.818 thread(3) tag(11) DETAIL plc_tag_generic_tickler:386 Done.
2023-08-29 14:43:16.818 thread(3) tag(0) DETAIL check_read_status_connected:1410 type byte = 198 (c6)
2023-08-29 14:43:16.818 thread(3) tag(0) INFO check_read_status_connected:1471 Got 1 bytes of data
2023-08-29 14:43:16.818 thread(3) tag(0) DETAIL rc_dec_impl:242 Calling cleanup functions due to call at check_read_status_connected:1504 for 0x55cd83263780.
2023-08-29 14:43:16.818 thread(3) tag(0) INFO refcount_cleanup:256 Starting
2023-08-29 14:43:16.818 thread(3) tag(0) DETAIL request_destroy:2559 Starting.
2023-08-29 14:43:16.818 thread(3) tag(0) DETAIL request_destroy:2568 Done.
2023-08-29 14:43:16.818 thread(3) tag(0) INFO refcount_cleanup:268 Done.
2023-08-29 14:43:16.818 thread(3) tag(0) DETAIL plc_tag_tickler_wake_impl:220 Starting. Called from tag_tickler_func:569.
2023-08-29 14:43:16.818 thread(3) tag(0) DETAIL plc_tag_tickler_wake_impl:233 Done. Called from tag_tickler_func:569.
2023-08-29 14:43:16.818 thread(1) tag(11) INFO plc_tag_read:1724 elapsed time 4ms
2023-08-29 14:43:16.818 thread(1) tag(11) INFO plc_tag_read:1737 Done
elem_count : 1
elem_size : 1
tag_size : 1
255
0xff

elem_count : 1
elem_size : 1
tag_size : 1
7
0x7
2023-08-29 14:43:16.818 thread(1) tag(11) INFO plc_tag_write:1816 Starting.
2023-08-29 14:43:16.818 thread(1) tag(11) INFO tag_write_start:357 Starting
2023-08-29 14:43:16.818 thread(1) tag(11) INFO build_write_request_connected:1000 Starting.
2023-08-29 14:43:16.818 thread(1) tag(11) DETAIL session_create_request:2517 Starting.
2023-08-29 14:43:16.818 thread(1) tag(11) INFO rc_alloc_impl:111 Starting, called from session_create_request:2526
2023-08-29 14:43:16.818 thread(1) tag(11) INFO rc_alloc_impl:130 Done
2023-08-29 14:43:16.818 thread(1) tag(11) DETAIL rc_alloc_impl:135 Returning memory pointer 0x55cd832637e0
2023-08-29 14:43:16.818 thread(1) tag(11) DETAIL session_create_request:2540 Done.
2023-08-29 14:43:16.818 thread(1) tag(11) DETAIL calculate_write_data_per_packet:1967 Starting.
2023-08-29 14:43:16.818 thread(1) tag(11) DETAIL calculate_write_data_per_packet:1971 Connected tag.
2023-08-29 14:43:16.818 thread(1) tag(11) DETAIL calculate_write_data_per_packet:1993 Write packet maximum size is 1996, write overhead is 28, and write data per packet is 1968.
2023-08-29 14:43:16.818 thread(1) tag(11) DETAIL calculate_write_data_per_packet:2008 Done.
2023-08-29 14:43:16.818 thread(1) tag(11) INFO session_add_request:960 Starting. sess=0x55cd83263d20, req=0x55cd832637e0
2023-08-29 14:43:16.818 thread(1) tag(11) DETAIL session_add_request_unsafe:925 Starting.
2023-08-29 14:43:16.818 thread(1) tag(11) DETAIL session_add_request_unsafe:944 Total requests in the queue: 1
2023-08-29 14:43:16.818 thread(1) tag(11) DETAIL session_add_request_unsafe:946 Done.
2023-08-29 14:43:16.818 thread(1) tag(11) INFO session_add_request:968 Done.
2023-08-29 14:43:16.818 thread(1) tag(11) INFO build_write_request_connected:1128 Done
2023-08-29 14:43:16.818 thread(1) tag(11) INFO tag_write_start:403 Done.
2023-08-29 14:43:16.818 thread(1) tag(11) DETAIL plc_tag_tickler_wake_impl:220 Starting. Called from plc_tag_write:1887.
2023-08-29 14:43:16.818 thread(1) tag(11) DETAIL plc_tag_tickler_wake_impl:233 Done. Called from plc_tag_write:1887.
2023-08-29 14:43:16.818 thread(2) tag(0) DETAIL session_handler:1162 in SESSION_IDLE state.
2023-08-29 14:43:16.818 thread(2) tag(0) DETAIL session_handler:1168 There are 1 requests pending before cleanup and sending.
2023-08-29 14:43:16.818 thread(2) tag(0) DETAIL get_payload_size:1673 Starting.
2023-08-29 14:43:16.818 thread(2) tag(0) DETAIL get_payload_size:1687 Done.
2023-08-29 14:43:16.818 thread(2) tag(0) INFO process_requests:1444 1 requests to process.
2023-08-29 14:43:16.818 thread(2) tag(0) INFO pack_requests:1708 Starting.
2023-08-29 14:43:16.818 thread(2) tag(11) INFO pack_requests:1718 Only one request, so done.
2023-08-29 14:43:16.818 thread(2) tag(0) INFO prepare_request:1810 Starting.
2023-08-29 14:43:16.818 thread(2) tag(0) DETAIL prepare_request:1839 cpf_targ_conn_id=43f91341
2023-08-29 14:43:16.818 thread(2) tag(0) INFO prepare_request:1847 Preparing connected packet with connection ID 75576da3 and sequence ID 3(3)
2023-08-29 14:43:16.818 thread(2) tag(0) INFO prepare_request:1854 Prepared packet of size 64
2023-08-29 14:43:16.818 thread(2) tag(0) INFO prepare_request:1855 00000 70 00 28 00 71 01 26 00 00 00 00 00 00 00 00 00
2023-08-29 14:43:16.818 thread(2) tag(0) INFO prepare_request:1855 00016 00 00 00 00 00 00 00 00 00 00 00 00 01 00 02 00
2023-08-29 14:43:16.818 thread(2) tag(0) INFO prepare_request:1855 00032 a1 00 04 00 41 13 f9 43 b1 00 14 00 03 00 4d 05
2023-08-29 14:43:16.818 thread(2) tag(0) INFO prepare_request:1855 00048 91 07 75 73 69 6e 74 5f 74 00 c6 00 01 00 07 00
2023-08-29 14:43:16.818 thread(2) tag(0) INFO prepare_request:1857 Done.
2023-08-29 14:43:16.819 thread(2) tag(0) INFO send_eip_request:1870 Starting.
2023-08-29 14:43:16.819 thread(2) tag(0) INFO send_eip_request:1883 Sending packet of size 64
2023-08-29 14:43:16.819 thread(2) tag(0) INFO send_eip_request:1884 00000 70 00 28 00 71 01 26 00 00 00 00 00 00 00 00 00
2023-08-29 14:43:16.819 thread(2) tag(0) INFO send_eip_request:1884 00016 00 00 00 00 00 00 00 00 00 00 00 00 01 00 02 00
2023-08-29 14:43:16.819 thread(2) tag(0) INFO send_eip_request:1884 00032 a1 00 04 00 41 13 f9 43 b1 00 14 00 03 00 4d 05
2023-08-29 14:43:16.819 thread(2) tag(0) INFO send_eip_request:1884 00048 91 07 75 73 69 6e 74 5f 74 00 c6 00 01 00 07 00
2023-08-29 14:43:16.819 thread(2) tag(0) DETAIL socket_write:1877 Starting.
2023-08-29 14:43:16.819 thread(3) tag(11) DETAIL tag_tickler_func:550 Tickling tag 11.
2023-08-29 14:43:16.819 thread(3) tag(11) DETAIL plc_tag_generic_tickler:281 Tickling tag 11.
2023-08-29 14:43:16.819 thread(3) tag(11) DETAIL plc_tag_generic_tickler:386 Done.
2023-08-29 14:43:16.819 thread(3) tag(0) DETAIL check_write_request_status:1181 Write not ready with status PLCTAG_STATUS_PENDING.
2023-08-29 14:43:16.819 thread(3) tag(0) DETAIL check_write_status_connected:1787 Write request status is not OK.
2023-08-29 14:43:16.819 thread(2) tag(0) DETAIL socket_write:1999 Done: result = 64.
2023-08-29 14:43:16.819 thread(2) tag(0) INFO send_eip_request:1926 Done.
2023-08-29 14:43:16.819 thread(2) tag(0) INFO recv_eip_response:1946 Starting.
2023-08-29 14:43:16.819 thread(2) tag(0) DETAIL socket_read:1754 Starting.
2023-08-29 14:43:16.819 thread(2) tag(0) DETAIL socket_read:1786 Immediate read attempt did not succeed, now wait for select().
2023-08-29 14:43:16.822 thread(2) tag(0) DETAIL socket_read:1814 Socket can read data.
2023-08-29 14:43:16.822 thread(2) tag(0) DETAIL socket_read:1866 Done: result 24.
2023-08-29 14:43:16.822 thread(2) tag(0) DETAIL socket_read:1754 Starting.
2023-08-29 14:43:16.822 thread(2) tag(0) DETAIL socket_read:1866 Done: result 30.
2023-08-29 14:43:16.826 thread(2) tag(0) INFO recv_eip_response:2017 request received all needed data (54 bytes of 54).
2023-08-29 14:43:16.826 thread(2) tag(0) INFO recv_eip_response:2019 00000 70 00 1e 00 71 01 26 00 00 00 00 00 00 00 00 00
2023-08-29 14:43:16.826 thread(2) tag(0) INFO recv_eip_response:2019 00016 00 00 00 00 00 00 00 00 00 00 00 00 00 00 02 00
2023-08-29 14:43:16.826 thread(2) tag(0) INFO recv_eip_response:2019 00032 a1 00 04 00 a3 6d 57 75 b1 00 0a 00 03 00 cd 00
2023-08-29 14:43:16.826 thread(2) tag(0) INFO recv_eip_response:2019 00048 1f 02 02 01 03 10
2023-08-29 14:43:16.826 thread(2) tag(0) INFO recv_eip_response:2026 Done.
2023-08-29 14:43:16.826 thread(2) tag(11) INFO unpack_response:1552 Starting.
2023-08-29 14:43:16.826 thread(2) tag(11) INFO unpack_response:1561 Got single response packet. Copying 54 bytes unchanged.
2023-08-29 14:43:16.826 thread(2) tag(11) INFO unpack_response:1650 Unpacked packet:
2023-08-29 14:43:16.826 thread(2) tag(11) INFO unpack_response:1651 00000 70 00 1e 00 71 01 26 00 00 00 00 00 00 00 00 00
2023-08-29 14:43:16.826 thread(2) tag(11) INFO unpack_response:1651 00016 00 00 00 00 00 00 00 00 00 00 00 00 00 00 02 00
2023-08-29 14:43:16.826 thread(2) tag(11) INFO unpack_response:1651 00032 a1 00 04 00 a3 6d 57 75 b1 00 0a 00 03 00 cd 00
2023-08-29 14:43:16.826 thread(2) tag(11) INFO unpack_response:1651 00048 1f 02 02 01 03 10
2023-08-29 14:43:16.826 thread(2) tag(11) DETAIL unpack_response:1660 Done.
2023-08-29 14:43:16.826 thread(2) tag(11) DETAIL plc_tag_tickler_wake_impl:220 Starting. Called from process_requests:1532.
2023-08-29 14:43:16.826 thread(2) tag(11) DETAIL plc_tag_tickler_wake_impl:233 Done. Called from process_requests:1532.
2023-08-29 14:43:16.826 thread(3) tag(11) DETAIL tag_tickler_func:550 Tickling tag 11.
2023-08-29 14:43:16.826 thread(3) tag(11) DETAIL plc_tag_generic_tickler:281 Tickling tag 11.
2023-08-29 14:43:16.826 thread(3) tag(11) DETAIL plc_tag_generic_tickler:386 Done.
2023-08-29 14:43:16.827 thread(3) tag(0) WARN check_write_status_connected:1819 CIP read failed with status: 0x1f Unknown error code.
2023-08-29 14:43:16.827 thread(3) tag(0) INFO check_write_status_connected:1820 Unknown error code.
2023-08-29 14:43:16.827 thread(3) tag(0) DETAIL rc_dec_impl:242 Calling cleanup functions due to call at check_write_status_connected:1837 for 0x55cd832637e0.
2023-08-29 14:43:16.827 thread(3) tag(0) INFO refcount_cleanup:256 Starting
2023-08-29 14:43:16.827 thread(3) tag(0) DETAIL request_destroy:2559 Starting.
2023-08-29 14:43:16.827 thread(3) tag(0) DETAIL request_destroy:2568 Done.
2023-08-29 14:43:16.827 thread(3) tag(0) INFO refcount_cleanup:268 Done.
2023-08-29 14:43:16.827 thread(3) tag(0) WARN check_write_status_connected:1852 Write failed!
2023-08-29 14:43:16.827 thread(3) tag(0) DETAIL plc_tag_tickler_wake_impl:220 Starting. Called from tag_tickler_func:582.
2023-08-29 14:43:16.827 thread(3) tag(0) DETAIL plc_tag_tickler_wake_impl:233 Done. Called from tag_tickler_func:582.
2023-08-29 14:43:16.827 thread(1) tag(11) WARN plc_tag_write:1916 Error PLCTAG_ERR_REMOTE_ERR while trying to write tag!
2023-08-29 14:43:16.827 thread(1) tag(11) INFO plc_tag_abort:1484 Starting.
2023-08-29 14:43:16.827 thread(1) tag(11) DETAIL ab_tag_abort:732 Starting.
2023-08-29 14:43:16.827 thread(1) tag(11) DETAIL ab_tag_abort:741 Called without a request in flight.
2023-08-29 14:43:16.827 thread(1) tag(11) DETAIL ab_tag_abort:748 Done.
2023-08-29 14:43:16.827 thread(1) tag(11) DETAIL plc_tag_tickler_wake_impl:220 Starting. Called from plc_tag_abort:1513.
2023-08-29 14:43:16.827 thread(1) tag(11) DETAIL plc_tag_tickler_wake_impl:233 Done. Called from plc_tag_abort:1513.
2023-08-29 14:43:16.827 thread(1) tag(11) INFO plc_tag_abort:1519 Done.
2023-08-29 14:43:16.827 thread(1) tag(11) INFO plc_tag_write:1928 Write finshed with elapsed time 9ms
2023-08-29 14:43:16.827 thread(1) tag(11) INFO plc_tag_write:1942 Done: status = PLCTAG_ERR_REMOTE_ERR.
ERROR:= Got error code -29: PLCTAG_ERR_REMOTE_ERR

2023-08-29 14:43:16.827 thread(1) tag(11) INFO plc_tag_destroy:1541 Starting.
2023-08-29 14:43:16.827 thread(1) tag(11) DETAIL hashtable_remove:232 Starting
2023-08-29 14:43:16.827 thread(1) tag(11) DETAIL hashtable_remove:250 Done
2023-08-29 14:43:16.827 thread(1) tag(11) DETAIL plc_tag_destroy:1558 Aborting any in-flight operations.
2023-08-29 14:43:16.827 thread(1) tag(11) DETAIL ab_tag_abort:732 Starting.
2023-08-29 14:43:16.827 thread(1) tag(11) DETAIL ab_tag_abort:741 Called without a request in flight.
2023-08-29 14:43:16.827 thread(1) tag(11) DETAIL ab_tag_abort:748 Done.
2023-08-29 14:43:16.827 thread(1) tag(11) DETAIL plc_tag_tickler_wake_impl:220 Starting. Called from plc_tag_destroy:1572.
2023-08-29 14:43:16.827 thread(1) tag(11) DETAIL plc_tag_tickler_wake_impl:233 Done. Called from plc_tag_destroy:1572.
2023-08-29 14:43:16.827 thread(1) tag(11) INFO plc_tag_destroy:1579 Done.
2023-08-29 14:43:16.827 thread(1) tag(0) INFO plc_tag_shutdown:1095 Starting.
2023-08-29 14:43:16.827 thread(1) tag(0) DETAIL plc_tag_shutdown:1101 Closing all tags.
2023-08-29 14:43:16.827 thread(1) tag(0) DETAIL plc_tag_shutdown:1133 All tags closed.
2023-08-29 14:43:16.827 thread(1) tag(0) DETAIL plc_tag_shutdown:1135 Cleaning up library resources.
2023-08-29 14:43:16.827 thread(1) tag(0) INFO ab_teardown:142 Releasing global AB protocol resources.
2023-08-29 14:43:16.827 thread(1) tag(0) INFO ab_teardown:153 IO thread already stopped.
2023-08-29 14:43:16.827 thread(1) tag(0) INFO ab_teardown:156 Freeing session information.
2023-08-29 14:43:16.827 thread(1) tag(0) INFO session_teardown:142 Starting.
2023-08-29 14:43:16.827 thread(1) tag(0) DETAIL session_teardown:145 Waiting for sessions to terminate.
2023-08-29 14:43:16.827 thread(3) tag(0) DETAIL rc_dec_impl:242 Calling cleanup functions due to call at tag_tickler_func:619 for 0x55cd83263980.
2023-08-29 14:43:16.827 thread(3) tag(0) INFO refcount_cleanup:256 Starting
2023-08-29 14:43:16.827 thread(3) tag(0) INFO ab_tag_destroy:800 Starting.
2023-08-29 14:43:16.827 thread(3) tag(0) DETAIL ab_tag_abort:732 Starting.
2023-08-29 14:43:16.827 thread(3) tag(0) DETAIL ab_tag_abort:741 Called without a request in flight.
2023-08-29 14:43:16.827 thread(3) tag(0) DETAIL ab_tag_abort:748 Done.
2023-08-29 14:43:16.827 thread(3) tag(0) DETAIL ab_tag_destroy:815 Getting ready to release tag session 0x55cd83263d20
2023-08-29 14:43:16.827 thread(3) tag(0) DETAIL ab_tag_destroy:817 Removing tag from session.
2023-08-29 14:43:16.827 thread(3) tag(0) DETAIL rc_dec_impl:242 Calling cleanup functions due to call at ab_tag_destroy:818 for 0x55cd83263d20.
2023-08-29 14:43:16.827 thread(3) tag(0) INFO refcount_cleanup:256 Starting
2023-08-29 14:43:16.827 thread(3) tag(0) INFO session_destroy:809 Starting.
2023-08-29 14:43:16.827 thread(3) tag(0) DETAIL remove_session:394 Starting.
2023-08-29 14:43:16.827 thread(3) tag(0) DETAIL remove_session_unsafe:370 Starting
2023-08-29 14:43:16.827 thread(3) tag(0) DETAIL remove_session_unsafe:385 Done
2023-08-29 14:43:16.827 thread(3) tag(0) DETAIL remove_session:402 Done.
2023-08-29 14:43:16.827 thread(3) tag(0) INFO session_destroy:820 Session sent 5 packets.
2023-08-29 14:43:16.827 thread(3) tag(0) DETAIL session_destroy:831 Destroying session thread.
2023-08-29 14:43:16.827 thread(3) tag(0) DETAIL thread_join:872 Starting.
2023-08-29 14:43:16.827 thread(2) tag(0) DETAIL session_handler:1319 Critical block.
2023-08-29 14:43:16.827 thread(3) tag(0) DETAIL thread_join:884 Done.
2023-08-29 14:43:16.827 thread(3) tag(0) DETAIL thread_destroy:913 Starting.
2023-08-29 14:43:16.827 thread(3) tag(0) DETAIL thread_destroy:924 Done.
2023-08-29 14:43:16.827 thread(3) tag(0) INFO perform_forward_close:2037 Starting.
2023-08-29 14:43:16.827 thread(3) tag(0) INFO send_forward_close_req:2402 Starting
2023-08-29 14:43:16.827 thread(3) tag(0) DETAIL send_forward_close_req:2414 Forward Close connection path:
2023-08-29 14:43:16.827 thread(3) tag(0) DETAIL send_forward_close_req:2415 00000 12 0d 31 39 32 2e 31 36 38 2e 32 35 30 2e 31 00
2023-08-29 14:43:16.827 thread(3) tag(0) DETAIL send_forward_close_req:2415 00016 20 02 24 01
2023-08-29 14:43:16.827 thread(3) tag(0) INFO send_eip_request:1870 Starting.
2023-08-29 14:43:16.827 thread(3) tag(0) INFO send_eip_request:1883 Sending packet of size 78
2023-08-29 14:43:16.827 thread(3) tag(0) INFO send_eip_request:1884 00000 6f 00 36 00 71 01 26 00 00 00 00 00 87 16 da 09
2023-08-29 14:43:16.827 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
2023-08-29 14:43:16.827 thread(3) tag(0) INFO send_eip_request:1884 00032 00 00 00 00 b2 00 26 00 4e 02 20 06 24 01 0a 05
2023-08-29 14:43:16.827 thread(3) tag(0) INFO send_eip_request:1884 00048 cb 1a 3d f3 45 43 50 21 0a 00 12 0d 31 39 32 2e
2023-08-29 14:43:16.827 thread(3) tag(0) INFO send_eip_request:1884 00064 31 36 38 2e 32 35 30 2e 31 00 20 02 24 01
2023-08-29 14:43:16.827 thread(3) tag(0) DETAIL socket_write:1877 Starting.
2023-08-29 14:43:16.828 thread(3) tag(0) DETAIL socket_write:1999 Done: result = 78.
2023-08-29 14:43:16.828 thread(3) tag(0) INFO send_eip_request:1926 Done.
2023-08-29 14:43:16.828 thread(3) tag(0) INFO send_forward_close_req:2454 Done
2023-08-29 14:43:16.828 thread(3) tag(0) INFO recv_forward_close_resp:2465 Starting
2023-08-29 14:43:16.828 thread(3) tag(0) INFO recv_eip_response:1946 Starting.
2023-08-29 14:43:16.828 thread(3) tag(0) DETAIL socket_read:1754 Starting.
2023-08-29 14:43:16.828 thread(3) tag(0) DETAIL socket_read:1786 Immediate read attempt did not succeed, now wait for select().
2023-08-29 14:43:16.832 thread(3) tag(0) DETAIL socket_read:1814 Socket can read data.
2023-08-29 14:43:16.832 thread(3) tag(0) DETAIL socket_read:1866 Done: result 24.
2023-08-29 14:43:16.832 thread(3) tag(0) DETAIL socket_read:1754 Starting.
2023-08-29 14:43:16.832 thread(3) tag(0) DETAIL socket_read:1866 Done: result 30.
2023-08-29 14:43:16.832 thread(3) tag(0) INFO recv_eip_response:2017 request received all needed data (54 bytes of 54).
2023-08-29 14:43:16.832 thread(3) tag(0) INFO recv_eip_response:2019 00000 6f 00 1e 00 71 01 26 00 00 00 00 00 87 16 da 09
2023-08-29 14:43:16.832 thread(3) tag(0) INFO recv_eip_response:2019 00016 00 00 00 00 00 00 00 00 00 00 00 00 01 00 02 00
2023-08-29 14:43:16.832 thread(3) tag(0) INFO recv_eip_response:2019 00032 00 00 00 00 b2 00 0e 00 ce 00 00 00 cb 1a 3d f3
2023-08-29 14:43:16.832 thread(3) tag(0) INFO recv_eip_response:2019 00048 45 43 50 21 00 00
2023-08-29 14:43:16.832 thread(3) tag(0) INFO recv_eip_response:2026 Done.
2023-08-29 14:43:16.832 thread(3) tag(0) INFO recv_forward_close_resp:2494 Connection close succeeded.
2023-08-29 14:43:16.832 thread(3) tag(0) INFO recv_forward_close_resp:2499 Done.
2023-08-29 14:43:16.832 thread(3) tag(0) INFO perform_forward_close:2053 Done.
2023-08-29 14:43:16.832 thread(3) tag(0) INFO session_unregister:777 Starting.
2023-08-29 14:43:16.832 thread(3) tag(0) INFO session_unregister:781 Done.
2023-08-29 14:43:16.832 thread(3) tag(0) INFO session_close_socket:790 Starting.
2023-08-29 14:43:16.832 thread(3) tag(0) INFO socket_close:2010 Starting.
2023-08-29 14:43:16.832 thread(3) tag(0) INFO socket_close:2046 Done.
2023-08-29 14:43:16.832 thread(3) tag(0) INFO socket_destroy:2056 Starting.
2023-08-29 14:43:16.832 thread(3) tag(0) INFO socket_close:2010 Starting.
2023-08-29 14:43:16.832 thread(3) tag(0) INFO socket_close:2046 Done.
2023-08-29 14:43:16.832 thread(3) tag(0) INFO socket_destroy:2069 Done.
2023-08-29 14:43:16.832 thread(3) tag(0) INFO session_close_socket:798 Done.
2023-08-29 14:43:16.832 thread(3) tag(0) DETAIL session_destroy:879 Destroying session condition variable.
2023-08-29 14:43:16.832 thread(3) tag(0) DETAIL cond_destroy:1182 Starting.
2023-08-29 14:43:16.832 thread(3) tag(0) DETAIL cond_destroy:1196 Done.
2023-08-29 14:43:16.832 thread(3) tag(0) DETAIL session_destroy:886 Destroying session mutex.
2023-08-29 14:43:16.832 thread(3) tag(0) DETAIL mutex_destroy:758 Starting to destroy mutex 0x55cd83264d90.
2023-08-29 14:43:16.832 thread(3) tag(0) DETAIL mutex_destroy:774 Done.
2023-08-29 14:43:16.832 thread(3) tag(0) DETAIL session_destroy:892 Cleaning up allocated memory for paths and host name.
2023-08-29 14:43:16.832 thread(3) tag(0) INFO session_destroy:908 Done.
2023-08-29 14:43:16.832 thread(3) tag(0) INFO refcount_cleanup:268 Done.
2023-08-29 14:43:16.832 thread(3) tag(0) DETAIL mutex_destroy:758 Starting to destroy mutex 0x55cd832639b8.
2023-08-29 14:43:16.832 thread(3) tag(0) DETAIL mutex_destroy:774 Done.
2023-08-29 14:43:16.832 thread(3) tag(0) DETAIL mutex_destroy:758 Starting to destroy mutex 0x55cd832639c0.
2023-08-29 14:43:16.832 thread(3) tag(0) DETAIL mutex_destroy:774 Done.
2023-08-29 14:43:16.832 thread(3) tag(0) DETAIL cond_destroy:1182 Starting.
2023-08-29 14:43:16.832 thread(3) tag(0) DETAIL cond_destroy:1196 Done.
2023-08-29 14:43:16.832 thread(3) tag(0) INFO ab_tag_destroy:849 Finished releasing all tag resources.
2023-08-29 14:43:16.832 thread(3) tag(0) INFO ab_tag_destroy:851 done
2023-08-29 14:43:16.832 thread(3) tag(0) INFO refcount_cleanup:268 Done.
2023-08-29 14:43:16.832 thread(3) tag(0) INFO tag_tickler_func:646 Terminating.
2023-08-29 14:43:16.838 thread(1) tag(0) DETAIL session_teardown:162 Sessions all terminated.
2023-08-29 14:43:16.838 thread(1) tag(0) DETAIL session_teardown:169 Destroying session mutex.
2023-08-29 14:43:16.838 thread(1) tag(0) DETAIL mutex_destroy:758 Starting to destroy mutex 0x7f779b60e8f8.
2023-08-29 14:43:16.838 thread(1) tag(0) DETAIL mutex_destroy:774 Done.
2023-08-29 14:43:16.838 thread(1) tag(0) INFO session_teardown:176 Done.
2023-08-29 14:43:16.838 thread(1) tag(0) INFO ab_teardown:162 Done.
2023-08-29 14:43:16.838 thread(1) tag(0) INFO mb_teardown:2427 Starting.
2023-08-29 14:43:16.838 thread(1) tag(0) DETAIL mb_teardown:2432 Waiting for all Modbus PLCs to terminate.
2023-08-29 14:43:16.838 thread(1) tag(0) DETAIL mb_teardown:2448 All Modbus PLCs terminated.
2023-08-29 14:43:16.838 thread(1) tag(0) DETAIL mb_teardown:2452 Destroying Modbus mutex.
2023-08-29 14:43:16.838 thread(1) tag(0) DETAIL mutex_destroy:758 Starting to destroy mutex 0x7f779b60e910.
2023-08-29 14:43:16.838 thread(1) tag(0) DETAIL mutex_destroy:774 Done.
2023-08-29 14:43:16.838 thread(1) tag(0) DETAIL mb_teardown:2456 Modbus mutex destroyed.
2023-08-29 14:43:16.838 thread(1) tag(0) INFO mb_teardown:2458 Done.
2023-08-29 14:43:16.838 thread(1) tag(0) INFO lib_teardown:176 Tearing down library.
2023-08-29 14:43:16.838 thread(1) tag(0) INFO lib_teardown:181 Signaling tag tickler condition var.
2023-08-29 14:43:16.838 thread(1) tag(0) INFO lib_teardown:186 Tearing down tag tickler thread.
2023-08-29 14:43:16.838 thread(1) tag(0) DETAIL thread_join:872 Starting.
2023-08-29 14:43:16.838 thread(1) tag(0) DETAIL thread_join:884 Done.
2023-08-29 14:43:16.838 thread(1) tag(0) DETAIL thread_destroy:913 Starting.
2023-08-29 14:43:16.838 thread(1) tag(0) DETAIL thread_destroy:924 Done.
2023-08-29 14:43:16.838 thread(1) tag(0) INFO lib_teardown:193 Tearing down tag tickler condition var.
2023-08-29 14:43:16.838 thread(1) tag(0) DETAIL cond_destroy:1182 Starting.
2023-08-29 14:43:16.838 thread(1) tag(0) DETAIL cond_destroy:1196 Done.
2023-08-29 14:43:16.838 thread(1) tag(0) INFO lib_teardown:199 Tearing down tag lookup mutex.
2023-08-29 14:43:16.838 thread(1) tag(0) DETAIL mutex_destroy:758 Starting to destroy mutex 0x7f779b60e8c0.
2023-08-29 14:43:16.838 thread(1) tag(0) DETAIL mutex_destroy:774 Done.
2023-08-29 14:43:16.838 thread(1) tag(0) INFO lib_teardown:205 Destroying tag hashtable.
2023-08-29 14:43:16.838 thread(1) tag(0) INFO hashtable_destroy:260 Starting
2023-08-29 14:43:16.838 thread(1) tag(0) INFO hashtable_destroy:272 Done
2023-08-29 14:43:16.838 thread(1) tag(0) INFO lib_teardown:212 Done.
2023-08-29 14:43:16.838 thread(1) tag(0) DETAIL mutex_destroy:758 Starting to destroy mutex 0x7f779b60e890.
2023-08-29 14:43:16.838 thread(1) tag(0) DETAIL mutex_destroy:774 Done.
2023-08-29 14:43:16.838 thread(1) tag(0) DETAIL plc_tag_unregister_logger:1368 Starting
2023-08-29 14:43:16.838 thread(1) tag(0) DETAIL plc_tag_unregister_logger:1372 Done.
2023-08-29 14:43:16.838 thread(1) tag(0) INFO plc_tag_shutdown:1142 Done.
@kyle-github
Copy link
Member

There is a CIP error, 0x1f, that is being returned from the PLC. Unfortunately, I can't find a definite source of what that means. The most I have been able to determine is that it is "vendor specific".

However, I do a possible issue here. It looks like the library is writing two bytes of data to the PLC instead of one. The packet is correct but there is a trailing zero byte that looks like it should not be there. I can read and write to Rockwell PLCs so it is possible that this is some sort of Omron-specific problem.

I am going to call this a bug and see if I can get rid of that extra byte.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
bug
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
2 participants
@kyle-github @tly-seven