Skip to content

jbpf_io_ipc_test passes with error messages #54

Open
@doctorlai-msrc

Description

@doctorlai-msrc

When serde and serde2.so are not given, the test pass despite showing error message:

root@6b97217dff19:/jbpf/build# jbpf_tests/functional/io/jbpf_io_ipc_test 
2025-03-17T11:15:41.435104Z [JBPF][IO][INFO]: Directory '/tmp/jbpf' already exists.
2025-03-17T11:15:41.439416Z [JBPF][IO][INFO]: Registered thread id 0
2025-03-17T11:15:41.439620Z [JBPF][MEM_MGMT][INFO]: Trying 2MB persistent huge pages (0 bytes)
2025-03-17T11:15:41.439654Z [JBPF][MEM_MGMT][INFO]: No huge page allocation
2025-03-17T11:15:41.439662Z [JBPF][MEM_MGMT][WARN]: Could not allocate memory
2025-03-17T11:15:41.439663Z [JBPF][MEM_MGMT][INFO]: Trying 2MB transparent huge pages (0 bytes)
2025-03-17T11:15:41.439678Z [JBPF][MEM_MGMT][WARN]: Could not allocate memory
2025-03-17T11:15:41.439721Z [JBPF][MEM_MGMT][INFO]: Let's try to allocate regular memory
2025-03-17T11:15:41.439724Z [JBPF][MEM_MGMT][INFO]: No huge page allocation
2025-03-17T11:15:41.455295Z [JBPF][MEM_MGMT][INFO]: Memory allocated successfully at address 0x7f8f46000000
2025-03-17T11:15:41.455365Z [JBPF][MEM_MGMT][INFO]: Allocated pages mlocked in memory
2025-03-17T11:15:41.458365Z [JBPF][MEM_MGMT][DEBUG]: Successfully created memory arena of size 33554432 at address 0x7f8f46000000
2025-03-17T11:15:41.459455Z [JBPF][IO][DEBUG]: Primary initialization successful
2025-03-17T11:15:41.459495Z [JBPF][IO][INFO]: Registered thread id 1
2025-03-17T11:15:41.459715Z [JBPF][IO][INFO]: Registered thread id 2
2025-03-17T11:15:41.459891Z [JBPF][IO][INFO]: Directory '/tmp/jbpf' already exists.
2025-03-17T11:15:41.463133Z [JBPF][IO][INFO]: Process connected. Initiating registration
2025-03-17T11:15:41.463148Z [JBPF][IO][INFO]: Received new incoming connection from control channel
2025-03-17T11:15:41.463632Z [JBPF][IO][INFO]: Sent registration request
2025-03-17T11:15:41.464705Z [JBPF][IO][INFO]: Registered new peer with socket fd 5
2025-03-17T11:15:41.464973Z [JBPF][MEM_MGMT][INFO]: Trying 1GB persistent huge pages (1073741824 bytes)
2025-03-17T11:15:41.465003Z [JBPF][MEM_MGMT][INFO]: No huge page allocation
2025-03-17T11:15:41.465007Z [JBPF][MEM_MGMT][INFO]: Openning shared memory with name jbpf_io_5
2025-03-17T11:15:41.465035Z [JBPF][MEM_MGMT][INFO]: Directory '/tmp/jbpf' already exists.
2025-03-17T11:15:41.465167Z [JBPF][MEM_MGMT][INFO]: Memory allocated successfully at address 0x7f8f00000000
2025-03-17T11:15:41.535305Z [JBPF][MEM_MGMT][INFO]: Allocated pages mlocked in memory
2025-03-17T11:15:41.642285Z [JBPF][IO][INFO]: Initiating negotiation with address 0x7f8f00000000
2025-03-17T11:15:41.642358Z [JBPF][IO][INFO]: Added context for sock_fd 5
2025-03-17T11:15:41.642921Z [JBPF][IO][INFO]: Got a local request
2025-03-17T11:15:41.642956Z [JBPF][IO][INFO]: Creating channel f5ffffffffffffffffffffffffffffff
2025-03-17T11:15:41.642947Z [JBPF][IO][INFO]: Received registration response with status 2
2025-03-17T11:15:41.642972Z [JBPF][MEM_MGMT][INFO]: Added 255 elements to the ringbuf
2025-03-17T11:15:41.642971Z [JBPF][IO][INFO]: Trying to mmap memory in address 0x7f8f00000000
2025-03-17T11:15:41.642975Z [JBPF][MEM_MGMT][INFO]: The size of the mempool is 255 and the capacity is 255
2025-03-17T11:15:41.642979Z [JBPF][MEM_MGMT][INFO]: Will try to read file /tmp/jbpf/jbpf_io_5
2025-03-17T11:15:41.643151Z [JBPF][IO][INFO]: Memory mapping succeeded
2025-03-17T11:15:41.643211Z [JBPF][IO][INFO]: Sending notification
2025-03-17T11:15:41.644173Z [JBPF][IO][INFO]: Waiting for peer update
2025-03-17T11:15:41.644287Z [JBPF][IO][INFO]: Found one context with sockfd 5
2025-03-17T11:15:41.644357Z [JBPF][IO][INFO]: Looked for context for sock_fd 5
2025-03-17T11:15:41.644412Z [JBPF][IO][INFO]: Received negotiation response 3 for reg_idx 5
2025-03-17T11:15:41.644468Z [JBPF][IO][INFO]: Negotiation was successful
2025-03-17T11:15:41.644482Z [JBPF][MEM_MGMT][DEBUG]: Successfully created memory arena of size 1073741824 at address 0x7f8f00000000
2025-03-17T11:15:41.644494Z [JBPF][IO][INFO]: Heap was created successfully
2025-03-17T11:15:41.645273Z [JBPF][IO][INFO]: Got a local request
2025-03-17T11:15:41.645321Z [JBPF][IO][INFO]: Received peer update with status 5
2025-03-17T11:15:41.645342Z [JBPF][IO][INFO]: Registration succeeded: memory name is jbpf_io_5 base address is 0x7f8f00000000
2025-03-17T11:15:41.645343Z [JBPF][IO][INFO]: Creating channel f5ffffffffffffffffffffffffffffff
2025-03-17T11:15:41.645353Z [JBPF][IO][INFO]: Registered thread id 0
2025-03-17T11:15:41.645356Z [JBPF][IO][WARN]: Channel f5ffffffffffffffffffffffffffffff already exists
**Failed to open file: (null)**
**Failed to open file: JBPF_PATH=/jbpf**
2025-03-17T11:15:41.645524Z [JBPF][IO][ERROR]: Channel was not created
2025-03-17T11:15:41.645606Z [JBPF][IO][INFO]: Requesting the creation of new channel for peer 3
2025-03-17T11:15:41.646762Z [JBPF][IO][INFO]: Received channel create request
2025-03-17T11:15:41.646825Z [JBPF][IO][INFO]: Found one context with sockfd 5
2025-03-17T11:15:41.646835Z [JBPF][IO][INFO]: Creating channel f1ffffffffffffffffffffffffffffff
2025-03-17T11:15:41.646861Z [JBPF][MEM_MGMT][INFO]: Added 255 elements to the ringbuf
2025-03-17T11:15:41.646914Z [JBPF][MEM_MGMT][INFO]: The size of the mempool is 255 and the capacity is 255
2025-03-17T11:15:41.647955Z [JBPF][IO][ERROR]: Unable to write serde lib serde_memfd_f1ffffffffffffffffffffffffffffff to memory
2025-03-17T11:15:41.648285Z [JBPF][IO][INFO]: Requesting the creation of new channel for peer 3
2025-03-17T11:15:41.648971Z [JBPF][IO][INFO]: Received channel create request
2025-03-17T11:15:41.649006Z [JBPF][IO][INFO]: Found one context with sockfd 5
2025-03-17T11:15:41.649013Z [JBPF][IO][INFO]: Creating channel f2fffffffffffffffffffffffffffff1
2025-03-17T11:15:41.649032Z [JBPF][MEM_MGMT][INFO]: Added 255 elements to the ringbuf
2025-03-17T11:15:41.649036Z [JBPF][MEM_MGMT][INFO]: The size of the mempool is 255 and the capacity is 255
2025-03-17T11:15:41.649722Z [JBPF][IO][INFO]: Requesting the creation of new channel for peer 3
2025-03-17T11:15:41.650761Z [JBPF][IO][INFO]: Received channel create request
2025-03-17T11:15:41.650785Z [JBPF][IO][INFO]: Found one context with sockfd 5
2025-03-17T11:15:41.650796Z [JBPF][IO][INFO]: Creating channel f3fffffffffffffffffffffffffffff2
2025-03-17T11:15:41.651046Z [JBPF][MEM_MGMT][INFO]: Added 8191 elements to the ringbuf
2025-03-17T11:15:41.651101Z [JBPF][MEM_MGMT][INFO]: The size of the mempool is 8191 and the capacity is 8191
2025-03-17T11:15:41.651673Z [JBPF][IO][INFO]: Requesting the creation of new channel for peer 3
2025-03-17T11:15:41.652714Z [JBPF][IO][INFO]: Received channel create request
2025-03-17T11:15:41.652794Z [JBPF][IO][INFO]: Found one context with sockfd 5
2025-03-17T11:15:41.652808Z [JBPF][IO][INFO]: Creating channel a3fffffffffffffffffffffffffffff2
2025-03-17T11:15:41.652831Z [JBPF][MEM_MGMT][INFO]: Added 255 elements to the ringbuf
2025-03-17T11:15:41.652895Z [JBPF][MEM_MGMT][INFO]: The size of the mempool is 255 and the capacity is 255
2025-03-17T11:15:41.654637Z [JBPF][IO][INFO]: Found one context with sockfd 5
2025-03-17T11:15:41.656330Z [JBPF][IO][INFO]: Found one context with sockfd 5
2025-03-17T11:15:41.657982Z [JBPF][IO][INFO]: Found one context with sockfd 5
2025-03-17T11:15:42.660312Z [JBPF][IO][INFO]: Got a local request
2025-03-17T11:15:42.660430Z [JBPF][IO][INFO]: Channel was removed from list successfully
2025-03-17T11:15:42.660444Z [JBPF][IO][INFO]: Releasing queue
2025-03-17T11:15:42.660452Z [JBPF][MEM_MGMT][INFO]: Mempool not ready to be destroyed during jbpf_destroy_mempool()
2025-03-17T11:15:42.660460Z [JBPF][IO][INFO]: Barrier reached and channel 0x7f8f46001680 was destroyed
2025-03-17T11:15:42.660600Z [JBPF][IO][INFO]: Local channel destroy request completed
2025-03-17T11:15:42.661369Z [JBPF][IO][INFO]: Requesting the destruction of channel f1ffffffffffffffffffffffffffffff for peer 3
2025-03-17T11:15:42.662735Z [JBPF][IO][INFO]: Found one context with sockfd 5
2025-03-17T11:15:42.662819Z [JBPF][IO][INFO]: Channel was removed from list successfully
2025-03-17T11:15:42.662837Z [JBPF][IO][INFO]: Releasing queue
2025-03-17T11:15:42.662847Z [JBPF][MEM_MGMT][INFO]: Mempool not ready to be destroyed during jbpf_destroy_mempool()
2025-03-17T11:15:42.662855Z [JBPF][IO][INFO]: Barrier reached and channel 0x7f8f00001680 was destroyed
2025-03-17T11:15:42.662853Z [JBPF][IO][INFO]: Requesting the destruction of channel f2fffffffffffffffffffffffffffff1 for peer 3
2025-03-17T11:15:42.663712Z [JBPF][IO][INFO]: Found one context with sockfd 5
2025-03-17T11:15:42.663800Z [JBPF][IO][INFO]: Requesting the destruction of channel f3fffffffffffffffffffffffffffff2 for peer 3
2025-03-17T11:15:42.663865Z [JBPF][IO][INFO]: Channel was removed from list successfully
2025-03-17T11:15:42.663879Z [JBPF][IO][INFO]: Releasing queue
2025-03-17T11:15:42.663886Z [JBPF][MEM_MGMT][INFO]: Mempool not ready to be destroyed during jbpf_destroy_mempool()
2025-03-17T11:15:42.663892Z [JBPF][IO][INFO]: Barrier reached and channel 0x7f8f00001900 was destroyed
2025-03-17T11:15:42.664434Z [JBPF][IO][INFO]: Found one context with sockfd 5
2025-03-17T11:15:42.664524Z [JBPF][IO][INFO]: Channel was removed from list successfully
2025-03-17T11:15:42.664536Z [JBPF][IO][INFO]: Releasing queue
2025-03-17T11:15:42.664543Z [JBPF][MEM_MGMT][INFO]: Mempool not ready to be destroyed during jbpf_destroy_mempool()
2025-03-17T11:15:42.664600Z [JBPF][IO][INFO]: Barrier reached and channel 0x7f8f00001b80 was destroyed
2025-03-17T11:15:42.666028Z [JBPF][IO][INFO]: Found one context with sockfd 5
2025-03-17T11:15:42.667766Z [JBPF][IO][INFO]: Found one context with sockfd 5
2025-03-17T11:15:42.670264Z [JBPF][IO][INFO]: Found one context with sockfd 5
2025-03-17T11:15:42.672289Z [JBPF][IO][INFO]: Found one context with sockfd 5
2025-03-17T11:15:42.672371Z [JBPF][IO][INFO]: Channel was destroyed successfully
2025-03-17T11:15:42.672384Z [JBPF][IO][INFO]: Releasing queue
2025-03-17T11:15:42.672392Z [JBPF][MEM_MGMT][INFO]: mempool destroyed from jbpf_destroy_mempool()
2025-03-17T11:15:42.672408Z [JBPF][IO][INFO]: Finished waiting on channel update
2025-03-17T11:15:42.758793Z [JBPF][IO][INFO]: Peer deregistered successfully
Test is now complete...
root@6b97217dff19:/jbpf/build# echo $?
0

Metadata

Metadata

Assignees

No one assigned

    Labels

    bugSomething isn't workinggood first issueGood for newcomers

    Type

    Projects

    No projects

    Milestone

    No milestone

    Relationships

    None yet

    Development

    No branches or pull requests

    Issue actions