Verify that configured Retrieve Cache is used by C-GET SCP : SERIES Level ==============dcm4che tool log================= getscu -c DCM4CHEE@localhost:11112 -m StudyInstanceUID=1.3.12.2.1107.5.8.1.12345678.199508041416590859569 -m SeriesInstanceUID=1.3.12.2.1107.5.8.1.12345678.199508041416590860429 -L SERIES 17:57:48,471 INFO - Initiate connection from 0.0.0.0/0.0.0.0:0 to localhost:11112 17:57:48,475 INFO - Established connection Socket[addr=localhost/127.0.0.1,port=11112,localport=33725] 17:57:48,483 DEBUG - /127.0.0.1:33725->localhost/127.0.0.1:11112(1): enter state: Sta4 - Awaiting transport connection opening to complete 17:57:48,484 INFO - GETSCU->DCM4CHEE(1) << A-ASSOCIATE-RQ 17:57:48,486 DEBUG - A-ASSOCIATE-RQ[ calledAET: DCM4CHEE callingAET: GETSCU applicationContext: 1.2.840.10008.3.1.1.1 - DICOM Application Context Name implClassUID: 1.2.40.0.13.1.3 implVersionName: dcm4che-5.13.3 maxPDULength: 16378 maxOpsInvoked/maxOpsPerformed: 0/0 PresentationContext[id: 1 as: 1.2.840.10008.5.1.4.1.2.2.3 - Study Root Query/Retrieve Information Model - GET ts: 1.2.840.10008.1.2 - Implicit VR Little Endian ts: 1.2.840.10008.1.2.1 - Explicit VR Little Endian ts: 1.2.840.10008.1.2.2 - Explicit VR Big Endian (Retired) ] .............................. .............................. RoleSelection[ sopClass: 1.2.840.10008.5.1.4.1.1.11.1 - Grayscale Softcopy Presentation State Storage scu: false scp: true ] .............................. .............................. ] 17:57:48,486 DEBUG - GETSCU->DCM4CHEE(1): enter state: Sta5 - Awaiting A-ASSOCIATE-AC or A-ASSOCIATE-RJ PDU 17:57:48,491 INFO - GETSCU->DCM4CHEE(1) >> A-ASSOCIATE-AC 17:57:48,492 DEBUG - A-ASSOCIATE-AC[ calledAET: DCM4CHEE callingAET: GETSCU applicationContext: 1.2.840.10008.3.1.1.1 - DICOM Application Context Name implClassUID: 1.2.40.0.13.1.3 implVersionName: dcm4che-5.13.3 maxPDULength: 16378 maxOpsInvoked/maxOpsPerformed: 0/0 PresentationContext[id: 1 result: 0 - acceptance ts: 1.2.840.10008.1.2 - Implicit VR Little Endian ] .............................. .............................. RoleSelection[ sopClass: 1.2.840.10008.5.1.4.1.1.11.1 - Grayscale Softcopy Presentation State Storage scu: false scp: true ] .............................. .............................. ] 17:57:48,492 DEBUG - GETSCU->DCM4CHEE(1): enter state: Sta6 - Association established and ready for data transfer 17:57:48,496 INFO - GETSCU->DCM4CHEE(1) << 1:C-GET-RQ[pcid=1, prior=0 cuid=1.2.840.10008.5.1.4.1.2.2.3 - Study Root Query/Retrieve Information Model - GET tsuid=1.2.840.10008.1.2 - Implicit VR Little Endian 17:57:48,514 DEBUG - Command: (0000,0002) UI [1.2.840.10008.5.1.4.1.2.2.3] AffectedSOPClassUID (0000,0100) US [16] CommandField (0000,0110) US [1] MessageID (0000,0700) US [0] Priority (0000,0800) US [0] CommandDataSetType 17:57:48,514 DEBUG - Dataset: (0008,0052) CS [SERIES] QueryRetrieveLevel (0020,000D) UI [1.3.12.2.1107.5.8.1.12345678.199508041416590859569] StudyInsta (0020,000E) UI [1.3.12.2.1107.5.8.1.12345678.199508041416590860429] SeriesInst 17:57:48,669 INFO - GETSCU->DCM4CHEE(1) >> 1:C-GET-RSP[pcid=1, remaining=2, completed=0, failed=0, warning=0, status=ff00H cuid=1.2.840.10008.5.1.4.1.2.2.3 - Study Root Query/Retrieve Information Model - GET tsuid=1.2.840.10008.1.2 - Implicit VR Little Endian 17:57:48,669 DEBUG - Command: (0000,0002) UI [1.2.840.10008.5.1.4.1.2.2.3] AffectedSOPClassUID (0000,0100) US [32784] CommandField (0000,0120) US [1] MessageIDBeingRespondedTo (0000,0800) US [257] CommandDataSetType (0000,0900) US [65280] Status (0000,1020) US [2] NumberOfRemainingSuboperations (0000,1021) US [0] NumberOfCompletedSuboperations (0000,1022) US [0] NumberOfFailedSuboperations (0000,1023) US [0] NumberOfWarningSuboperations 17:57:48,928 INFO - GETSCU->DCM4CHEE(1) >> 1:C-STORE-RQ[pcid=27, prior=0 cuid=1.2.840.10008.5.1.4.1.1.2 - CT Image Storage iuid=1.3.12.2.1107.5.8.1.12345678.199508041416590861483 - ? tsuid=1.2.840.10008.1.2 - Implicit VR Little Endian 17:57:48,928 DEBUG - Command: (0000,0002) UI [1.2.840.10008.5.1.4.1.1.2] AffectedSOPClassUID (0000,0100) US [1] CommandField (0000,0110) US [1] MessageID (0000,0700) US [0] Priority (0000,0800) US [0] CommandDataSetType (0000,1000) UI [1.3.12.2.1107.5.8.1.12345678.199508041416590861483] AffectedSO 17:57:48,928 INFO - GETSCU->DCM4CHEE(1) << 1:C-STORE-RSP[pcid=27, status=0H cuid=1.2.840.10008.5.1.4.1.1.2 - CT Image Storage iuid=1.3.12.2.1107.5.8.1.12345678.199508041416590861483 - ? tsuid=1.2.840.10008.1.2 - Implicit VR Little Endian 17:57:48,928 DEBUG - Command: (0000,0002) UI [1.2.840.10008.5.1.4.1.1.2] AffectedSOPClassUID (0000,0100) US [32769] CommandField (0000,0120) US [1] MessageIDBeingRespondedTo (0000,0800) US [257] CommandDataSetType (0000,0900) US [0] Status (0000,1000) UI [1.3.12.2.1107.5.8.1.12345678.199508041416590861483] AffectedSO 17:57:48,929 DEBUG - GETSCU->DCM4CHEE(1): Service User did not consume 529386 bytes of DIMSE data. 17:57:48,930 INFO - GETSCU->DCM4CHEE(1) >> 1:C-GET-RSP[pcid=1, remaining=1, completed=1, failed=0, warning=0, status=ff00H cuid=1.2.840.10008.5.1.4.1.2.2.3 - Study Root Query/Retrieve Information Model - GET tsuid=1.2.840.10008.1.2 - Implicit VR Little Endian 17:57:48,930 DEBUG - Command: (0000,0002) UI [1.2.840.10008.5.1.4.1.2.2.3] AffectedSOPClassUID (0000,0100) US [32784] CommandField (0000,0120) US [1] MessageIDBeingRespondedTo (0000,0800) US [257] CommandDataSetType (0000,0900) US [65280] Status (0000,1020) US [1] NumberOfRemainingSuboperations (0000,1021) US [1] NumberOfCompletedSuboperations (0000,1022) US [0] NumberOfFailedSuboperations (0000,1023) US [0] NumberOfWarningSuboperations 17:57:48,981 INFO - GETSCU->DCM4CHEE(1) >> 2:C-STORE-RQ[pcid=27, prior=0 cuid=1.2.840.10008.5.1.4.1.1.2 - CT Image Storage iuid=1.3.12.2.1107.5.8.1.12345678.199508041417040742898 - ? tsuid=1.2.840.10008.1.2 - Implicit VR Little Endian 17:57:48,981 DEBUG - Command: (0000,0002) UI [1.2.840.10008.5.1.4.1.1.2] AffectedSOPClassUID (0000,0100) US [1] CommandField (0000,0110) US [2] MessageID (0000,0700) US [0] Priority (0000,0800) US [0] CommandDataSetType (0000,1000) UI [1.3.12.2.1107.5.8.1.12345678.199508041417040742898] AffectedSO 17:57:48,982 INFO - GETSCU->DCM4CHEE(1) << 2:C-STORE-RSP[pcid=27, status=0H cuid=1.2.840.10008.5.1.4.1.1.2 - CT Image Storage iuid=1.3.12.2.1107.5.8.1.12345678.199508041417040742898 - ? tsuid=1.2.840.10008.1.2 - Implicit VR Little Endian 17:57:48,982 DEBUG - Command: (0000,0002) UI [1.2.840.10008.5.1.4.1.1.2] AffectedSOPClassUID (0000,0100) US [32769] CommandField (0000,0120) US [2] MessageIDBeingRespondedTo (0000,0800) US [257] CommandDataSetType (0000,0900) US [0] Status (0000,1000) UI [1.3.12.2.1107.5.8.1.12345678.199508041417040742898] AffectedSO 17:57:48,983 DEBUG - GETSCU->DCM4CHEE(1): Service User did not consume 529386 bytes of DIMSE data. 17:57:49,003 INFO - GETSCU->DCM4CHEE(1) >> 1:C-GET-RSP[pcid=1, completed=2, failed=0, warning=0, status=0H cuid=1.2.840.10008.5.1.4.1.2.2.3 - Study Root Query/Retrieve Information Model - GET tsuid=1.2.840.10008.1.2 - Implicit VR Little Endian 17:57:49,004 DEBUG - Command: (0000,0002) UI [1.2.840.10008.5.1.4.1.2.2.3] AffectedSOPClassUID (0000,0100) US [32784] CommandField (0000,0120) US [1] MessageIDBeingRespondedTo (0000,0800) US [257] CommandDataSetType (0000,0900) US [0] Status (0000,1021) US [2] NumberOfCompletedSuboperations (0000,1022) US [0] NumberOfFailedSuboperations (0000,1023) US [0] NumberOfWarningSuboperations 17:57:49,004 INFO - GETSCU->DCM4CHEE(1) << A-RELEASE-RQ 17:57:49,004 DEBUG - GETSCU->DCM4CHEE(1): enter state: Sta7 - Awaiting A-RELEASE-RP PDU 17:57:49,004 INFO - GETSCU->DCM4CHEE(1) >> A-RELEASE-RP 17:57:49,004 INFO - GETSCU->DCM4CHEE(1): close Socket[addr=localhost/127.0.0.1,port=11112,localport=33725] 17:57:49,004 DEBUG - GETSCU->DCM4CHEE(1): enter state: Sta1 - Idle =============Wildfly Server log================ 17:57:48,663 INFO [org.dcm4che3.net.Dimse] (EE-ManagedExecutorService-default-Thread-7) DCM4CHEE<-GETSCU(2) << 1:C-GET-RSP[pcid=1, remaining=2, completed=0, failed=0, warning=0, status=ff00H cuid=1.2.840.10008.5.1.4.1.2.2.3 - Study Root Query/Retrieve Information Model - GET tsuid=1.2.840.10008.1.2 - Implicit VR Little Endian 17:57:48,663 DEBUG [org.dcm4che3.net.Dimse] (EE-ManagedExecutorService-default-Thread-7) Command: (0000,0002) UI [1.2.840.10008.5.1.4.1.2.2.3] AffectedSOPClassUID (0000,0100) US [32784] CommandField (0000,0120) US [1] MessageIDBeingRespondedTo (0000,0800) US [257] CommandDataSetType (0000,0900) US [65280] Status (0000,1020) US [2] NumberOfRemainingSuboperations (0000,1021) US [0] NumberOfCompletedSuboperations (0000,1022) US [0] NumberOfFailedSuboperations (0000,1023) US [0] NumberOfWarningSuboperations .............................. .............................. 17:57:48,917 DEBUG [org.dcm4chee.arc.retrieve.impl.CopyToRetrieveCacheTask] (EE-ManagedExecutorService-default-Thread-7) Got next finished copy to retrieve cache 17:57:48,918 DEBUG [org.dcm4chee.arc.retrieve.impl.RetrieveServiceImpl] (EE-ManagedExecutorService-default-Thread-7) Read Instance[iuid=1.3.12.2.1107.5.8.1.12345678.199508041416590861483,cuid=1.2.840.10008.5.1.4.1.1.2] from Location[pk=9680, systemID=retrieve-cache, path=2018/05/25/5E9204E8/5E9C00D5/5E9C75E8, tsuid=1.2.840.10008.1.2, size=529440, status=OK, objectType=DICOM_FILE] 17:57:48,923 DEBUG [org.dcm4che3.util.ReverseDNS] (EE-ManagedExecutorService-default-Thread-7) rDNS 127.0.0.1 -> ... 17:57:48,923 DEBUG [org.dcm4che3.util.ReverseDNS] (EE-ManagedExecutorService-default-Thread-7) rDNS 127.0.0.1 -> localhost in 1 ms 17:57:48,924 INFO [org.dcm4che3.net.Dimse] (EE-ManagedExecutorService-default-Thread-7) DCM4CHEE<-GETSCU(2) << 1:C-STORE-RQ[pcid=27, prior=0 cuid=1.2.840.10008.5.1.4.1.1.2 - CT Image Storage iuid=1.3.12.2.1107.5.8.1.12345678.199508041416590861483 - ? tsuid=1.2.840.10008.1.2 - Implicit VR Little Endian 17:57:48,924 DEBUG [org.dcm4che3.net.Dimse] (EE-ManagedExecutorService-default-Thread-7) Command: (0000,0002) UI [1.2.840.10008.5.1.4.1.1.2] AffectedSOPClassUID (0000,0100) US [1] CommandField (0000,0110) US [1] MessageID (0000,0700) US [0] Priority (0000,0800) US [0] CommandDataSetType (0000,1000) UI [1.3.12.2.1107.5.8.1.12345678.199508041416590861483] AffectedSO .............................. .............................. 17:57:48,929 INFO [org.dcm4che3.net.Dimse] (EE-ManagedExecutorService-default-Thread-6) DCM4CHEE<-GETSCU(2) >> 1:C-STORE-RSP[pcid=27, status=0H cuid=1.2.840.10008.5.1.4.1.1.2 - CT Image Storage iuid=1.3.12.2.1107.5.8.1.12345678.199508041416590861483 - ? tsuid=1.2.840.10008.1.2 - Implicit VR Little Endian 17:57:48,929 DEBUG [org.dcm4che3.net.Dimse] (EE-ManagedExecutorService-default-Thread-6) Command: (0000,0002) UI [1.2.840.10008.5.1.4.1.1.2] AffectedSOPClassUID (0000,0100) US [32769] CommandField (0000,0120) US [1] MessageIDBeingRespondedTo (0000,0800) US [257] CommandDataSetType (0000,0900) US [0] Status (0000,1000) UI [1.3.12.2.1107.5.8.1.12345678.199508041416590861483] AffectedSO 17:57:48,930 INFO [org.dcm4che3.net.Dimse] (EE-ManagedExecutorService-default-Thread-6) DCM4CHEE<-GETSCU(2) << 1:C-GET-RSP[pcid=1, remaining=1, completed=1, failed=0, warning=0, status=ff00H cuid=1.2.840.10008.5.1.4.1.2.2.3 - Study Root Query/Retrieve Information Model - GET tsuid=1.2.840.10008.1.2 - Implicit VR Little Endian 17:57:48,930 DEBUG [org.dcm4chee.arc.retrieve.impl.CopyToRetrieveCacheTask] (EE-ManagedExecutorService-default-Thread-7) Wait for next finished copy to retrieve cache 17:57:48,930 DEBUG [org.dcm4che3.net.Dimse] (EE-ManagedExecutorService-default-Thread-6) Command: (0000,0002) UI [1.2.840.10008.5.1.4.1.2.2.3] AffectedSOPClassUID (0000,0100) US [32784] CommandField (0000,0120) US [1] MessageIDBeingRespondedTo (0000,0800) US [257] CommandDataSetType (0000,0900) US [65280] Status (0000,1020) US [1] NumberOfRemainingSuboperations (0000,1021) US [1] NumberOfCompletedSuboperations (0000,1022) US [0] NumberOfFailedSuboperations (0000,1023) US [0] NumberOfWarningSuboperations .............................. .............................. 17:57:48,977 DEBUG [org.dcm4chee.arc.retrieve.impl.CopyToRetrieveCacheTask] (EE-ManagedExecutorService-default-Thread-7) Got next finished copy to retrieve cache 17:57:48,978 DEBUG [org.dcm4chee.arc.retrieve.impl.RetrieveServiceImpl] (EE-ManagedExecutorService-default-Thread-7) Read Instance[iuid=1.3.12.2.1107.5.8.1.12345678.199508041417040742898,cuid=1.2.840.10008.5.1.4.1.1.2] from Location[pk=9681, systemID=retrieve-cache, path=2018/05/25/5E9204E8/5E9C00D5/6459578D, tsuid=1.2.840.10008.1.2, size=529440, status=OK, objectType=DICOM_FILE] 17:57:48,979 INFO [org.dcm4che3.net.Dimse] (EE-ManagedExecutorService-default-Thread-7) DCM4CHEE<-GETSCU(2) << 2:C-STORE-RQ[pcid=27, prior=0 cuid=1.2.840.10008.5.1.4.1.1.2 - CT Image Storage iuid=1.3.12.2.1107.5.8.1.12345678.199508041417040742898 - ? tsuid=1.2.840.10008.1.2 - Implicit VR Little Endian 17:57:48,979 DEBUG [org.dcm4che3.net.Dimse] (EE-ManagedExecutorService-default-Thread-7) Command: (0000,0002) UI [1.2.840.10008.5.1.4.1.1.2] AffectedSOPClassUID (0000,0100) US [1] CommandField (0000,0110) US [2] MessageID (0000,0700) US [0] Priority (0000,0800) US [0] CommandDataSetType (0000,1000) UI [1.3.12.2.1107.5.8.1.12345678.199508041417040742898] AffectedSO 17:57:48,982 INFO [org.dcm4che3.net.Dimse] (EE-ManagedExecutorService-default-Thread-6) DCM4CHEE<-GETSCU(2) >> 2:C-STORE-RSP[pcid=27, status=0H cuid=1.2.840.10008.5.1.4.1.1.2 - CT Image Storage iuid=1.3.12.2.1107.5.8.1.12345678.199508041417040742898 - ? tsuid=1.2.840.10008.1.2 - Implicit VR Little Endian 17:57:48,982 DEBUG [org.dcm4che3.net.Dimse] (EE-ManagedExecutorService-default-Thread-6) Command: (0000,0002) UI [1.2.840.10008.5.1.4.1.1.2] AffectedSOPClassUID (0000,0100) US [32769] CommandField (0000,0120) US [2] MessageIDBeingRespondedTo (0000,0800) US [257] CommandDataSetType (0000,0900) US [0] Status (0000,1000) UI [1.3.12.2.1107.5.8.1.12345678.199508041417040742898] AffectedSO .............................. .............................. 17:57:49,002 DEBUG [org.dcm4chee.arc.retrieve.impl.CopyToRetrieveCacheTask] (EE-ManagedExecutorService-default-Thread-7) Got next finished copy to retrieve cache 17:57:49,002 INFO [org.dcm4che3.net.Dimse] (EE-ManagedExecutorService-default-Thread-7) DCM4CHEE<-GETSCU(2) << 1:C-GET-RSP[pcid=1, completed=2, failed=0, warning=0, status=0H cuid=1.2.840.10008.5.1.4.1.2.2.3 - Study Root Query/Retrieve Information Model - GET tsuid=1.2.840.10008.1.2 - Implicit VR Little Endian 17:57:49,003 DEBUG [org.dcm4che3.net.Dimse] (EE-ManagedExecutorService-default-Thread-7) Command: (0000,0002) UI [1.2.840.10008.5.1.4.1.2.2.3] AffectedSOPClassUID (0000,0100) US [32784] CommandField (0000,0120) US [1] MessageIDBeingRespondedTo (0000,0800) US [257] CommandDataSetType (0000,0900) US [0] Status (0000,1021) US [2] NumberOfCompletedSuboperations (0000,1022) US [0] NumberOfFailedSuboperations (0000,1023) US [0] NumberOfWarningSuboperations