Association Issue between McKesson PACS and dcm4che PACS

KM

unread,

Jul 10, 2015, 11:05:17 AM7/10/15

to dcm...@googlegroups.com

Hi

Would appreciate anyone in the community who can help us with this challenge that we are trying to address in our setup.

Our Setup:

dcm4che PACS Server -> On Linux Host -> Hosted in Amazon EC2 --> Site to

Site VPN Tunnel -> Clients Cisco ASA -> Clients Network -> McKesson PACS -> Clients Modality Machine

What we are trying to do:

Client is trying to push studies to us from their PACS system to our PACS server.

Attached is our PACS server log.

Client says that the association phase is not being established when he attempts to push studies to us.

Based on the logs on our side, we are not seeing any error messages.

What might be the issue or what are things that we can verify to make progress in

being able to receive studies from the client PACS system into ours ?

log.docx

fleetwoodfc

unread,

Jul 10, 2015, 12:30:50 PM7/10/15

to dcm...@googlegroups.com, kmu...@mdchat.com

The log shows PACSCONNECTOR trying to Q/R DCM4CHEE - push studies would be a STORE transaction not a Q/R

KM

unread,

Jul 13, 2015, 8:45:15 AM7/13/15

to dcm...@googlegroups.com

Thank you for your feedback. We are working with our client and will provide updates/logs.

KM

unread,

Jul 13, 2015, 10:40:47 PM7/13/15

to dcm...@googlegroups.com

Hi Everyone

Requesting your expertise/guidance on this challenge of ours.

To re-iterate,this is what we are trying to do.

Our Setup:

dm4che PACS Server -> On Linux Host -> Hosted in Amazon EC2 --> Site to

Site VPN Tunnel -> Clients ASA -> Clients Network -> Client PACS System(McKesson)->Client Modality Machine

What we are trying to do:

Client is trying to push studies from the their PACS(McKesson) to our PACS(dcm4chee) server.

Clients PACS(McKesson) system conformance statement is

http://www.mckesson.com/documents/providers/mckesson-radiology-12-dicom-conformance-statement/

or this

http://www.mckesson.com/documents/providers/health-systems/department-solutions/horizon-medical-imaging-11_9-dicom-conformance-statement/

Our PACS(dcm4chee) system conformance statement is this

http://www.dcm4che.org/docs/conformance/dcm4chee-cs.pdf

Below is our PACS(dcm4chee) server log.

The log clearly says that the abstract syntax that the client is negotiating with us is not supported by our PACS system

Also, further down, the client did try converting the DICOM to fit into an acceptable SOP class, which failed.

Based on the two logs below,can you please suggest on how can we (dcm4chee) or the client(McKesson) can

make changes to arrive at a working SOP class and transfer syntax.

——dcm4chee log start---------------------

2015-07-13 13:56:09,225 INFO -> (TCPServer-1) [org.dcm4cheri.server.ServerImpl] handle - Socket[addr=/210.10.21.171,port=3737,localport=11112]

2015-07-13 13:56:09,226 INFO -> (TCPServer-1) [org.dcm4cheri.net.FsmImpl] Socket[addr=/210.10.21.171,port=3737,localport=11112]

2015-07-13 13:56:09,244 INFO ALI_SCU->DCM4CHEE (TCPServer-1) [org.dcm4cheri.net.FsmImpl] received AAssociateRQ

appCtxName: 1.2.840.10008.3.1.1.1/DICOM Application Context Name

implClass: 1.2.840.113711.1

implVersion: V1.0

calledAET: DCM4CHEE

callingAET: ALI_SCU

maxPDULen: 16384

asyncOpsWindow:

pc-1: as=1.2.840.10008.5.1.4.1.1.2/CT Image Storage

ts=1.2.840.10008.1.2/Implicit VR Little Endian

pc-3: as=1.2.840.10008.5.1.4.1.1.2/CT Image Storage

ts=1.2.840.10008.1.2.4.50/JPEG Baseline (Process 1)

pc-5: as=1.2.840.10008.5.1.4.1.1.2/CT Image Storage

ts=1.2.840.10008.1.2.4.70/JPEG Lossless, Non- Hierarchical, First-Order Prediction (Process 14 [Selection Value 1])

RoleSelection[sop=1.2.840.10008.5.1.4.1.1.2/CT Image Storage, scu=true, scp=false]

2015-07-13 13:56:09,247 INFO ALI_SCU->DCM4CHEE (TCPServer-1) [org.dcm4cheri.net.FsmImpl] sending AAssociateAC

appCtxName: 1.2.840.10008.3.1.1.1/DICOM Application Context Name

implClass: 1.2.40.0.13.1.1.1

implVersion: dcm4che-1.4.31

calledAET: DCM4CHEE

callingAET: ALI_SCU

maxPDULen: 16352

asyncOpsWindow:

pc-1: 3 - abstract-syntax-not-supported

ts=1.2.840.10008.1.2/Implicit VR Little Endian

pc-3: 3 - abstract-syntax-not-supported

ts=1.2.840.10008.1.2.4.50/JPEG Baseline (Process 1)

pc-5: 3 - abstract-syntax-not-supported

ts=1.2.840.10008.1.2.4.70/JPEG Lossless, Non- Hierarchical, First-Order Prediction (Process 14 [Selection Value 1])

RoleSelection[sop=1.2.840.10008.5.1.4.1.1.2/CT Image Storage, scu=true, scp=false]

2015-07-13 13:56:09,443 INFO ALI_SCU->DCM4CHEE (TCPServer-1) [org.dcm4cheri.net.FsmImpl] received A-RELEASE-RQ

2015-07-13 13:56:09,443 INFO ALI_SCU->DCM4CHEE (TCPServer-1) [org.dcm4cheri.net.FsmImpl] sending A-RELEASE-RP

2015-07-13 13:56:09,494 INFO ALI_SCU->DCM4CHEE (TCPServer-1) [org.dcm4cheri.net.FsmImpl] closing connection - Socket[addr=/210.10.21.171,port=3737,localport=11112]

2015-07-13 13:56:09,494 INFO -> (TCPServer-1) [org.dcm4cheri.server.ServerImpl] finished - Socket[addr=/210.10.21.171,port=3737,localport=11112]

——————dch4chee log end———————

———McKesson PACS log start—————

[ut.c,584 09:58:34.360] ut_make_temp_dir ( "DicomServer_server8_856_458488714_-248614862_1" ) called
[DicomServer.m,1123 09:58:34.360] Created temporary directory "h:\samali\mysite\temp\DicomServer_server8_856_458488714_-248614862_1\server8_856_458488714_-248614862_2".
[utfile.c,322 09:58:34.360] ut_file_add_separator("h:\samali\mysite\temp\DicomServer_server8_856_458488714_-248614862_1\server8_856_458488714_-248614862_2") called
[DicomServer.m,1175 09:58:34.360] Transfer Syntax of image \\server8\f\img1\w4422374\view0001.dcm is 1.2.840.10008.1.2.4.70.
[ali_dipreprocess.c,2168 09:58:34.375] ERROR: Failed to convert "1.2.840.10008.5.1.4.1.1.2" to an acceptable SOP Class.
[ali_dipreprocess.c,1323 09:58:34.375] ERROR: Failure while trying to determine which SOP Class to use for exporting the Image Object: SRV_NOSERVICEINASSOCIATION.
[ali_dipreprocess.c,1413 09:58:34.375] ERROR: Failure while attempting to preprocess DICOM Object prior to export: SRV_NOSERVICEINASSOCIATION.
[ut.c,215 09:58:34.375] ut_remove_temp_path ("DicomServer_fhnode8_856_458488714_-248614862_1") called
[DicomServer.m,1543 09:58:34.375] QueryServer Preprocessing Time Log :

———McKesson PACS log end—————

Ravindran Padmanabhan

unread,

Jul 14, 2015, 11:59:14 AM7/14/15

to dcm...@googlegroups.com

Check this link in Storage SCP's under section AcceptedImageSOPClasses, check CT Image Storage is added and under AcceptedTransferSyntaxForImageSOPClasses ensure ExplicitVRLittleEndian & ImplicitVRLittleEndian are included. Restart the dcm4chee service.

with regards

Rady

KM

unread,

Jul 17, 2015, 5:59:59 PM7/17/15

to dcm...@googlegroups.com

Hello Everyone

After checking few things, we have found that we gave our client the wrong destination. AE title mismatch.

Once we pointed them to a storage archive server, things started working better.

For your reference, I am sharing the log. Appreciate the feedback you all have given.

2015-07-17 15:05:53,185 INFO -> (TCPServer-1-1) [org.dcm4cheri.server.ServerImpl] handle - Socket[addr=/210.10.21.171,port=3224,localport=11112]

2015-07-17 15:05:53,186 INFO -> (TCPServer-1-1) [org.dcm4cheri.net.FsmImpl] Socket[addr=/210.10.21.171,port=3224,localport=11112]

2015-07-17 15:05:53,214 INFO ALI_SCU->VMP (TCPServer-1-1) [org.dcm4cheri.net.FsmImpl] received AAssociateRQ

appCtxName: 1.2.840.10008.3.1.1.1/DICOM Application Context Name

implClass: 1.2.840.113711.1

implVersion: V1.0

calledAET: VMP

callingAET: ALI_SCU

maxPDULen: 16384

asyncOpsWindow:

pc-1: as=1.2.840.10008.5.1.4.1.1.7/Secondary Capture Image Storage

ts=1.2.840.10008.1.2/Implicit VR Little Endian

pc-3: as=1.2.840.10008.5.1.4.1.1.7/Secondary Capture Image Storage

ts=1.2.840.10008.1.2.4.50/JPEG Baseline (Process 1)

pc-5: as=1.2.840.10008.5.1.4.1.1.7/Secondary Capture Image Storage

ts=1.2.840.10008.1.2.4.70/JPEG Lossless, Non- Hierarchical, First-Order Prediction (Process 14 [Selection Value 1])

pc-7: as=1.2.840.10008.5.1.4.1.1.88.59/Key Object Selection Document

ts=1.2.840.10008.1.2/Implicit VR Little Endian

RoleSelection[sop=1.2.840.10008.5.1.4.1.1.7/Secondary Capture Image Storage, scu=true, scp=false]

RoleSelection[sop=1.2.840.10008.5.1.4.1.1.88.59/Key Object Selection Document, scu=true, scp=false]

2015-07-17 15:05:53,217 INFO ALI_SCU->VMP (TCPServer-1-1) [org.dcm4cheri.net.FsmImpl] sending AAssociateAC

appCtxName: 1.2.840.10008.3.1.1.1/DICOM Application Context Name

implClass: 1.2.40.0.13.1.1.1

implVersion: dcm4che-1.4.31

calledAET: VMP

callingAET: ALI_SCU

maxPDULen: 16352

asyncOpsWindow:

pc-1: 0 - acceptance

ts=1.2.840.10008.1.2/Implicit VR Little Endian

pc-3: 0 - acceptance

ts=1.2.840.10008.1.2.4.50/JPEG Baseline (Process 1)

pc-5: 0 - acceptance

ts=1.2.840.10008.1.2.4.70/JPEG Lossless, Non- Hierarchical, First-Order Prediction (Process 14 [Selection Value 1])

pc-7: 0 - acceptance

ts=1.2.840.10008.1.2/Implicit VR Little Endian

RoleSelection[sop=1.2.840.10008.5.1.4.1.1.7/Secondary Capture Image Storage, scu=true, scp=false]

RoleSelection[sop=1.2.840.10008.5.1.4.1.1.88.59/Key Object Selection Document, scu=true, scp=false]

2015-07-17 15:05:53,590 INFO ALI_SCU->VMP (TCPServer-1-1) [org.dcm4cheri.net.FsmImpl] received [pc-5] 1:C_STORE_RQ with Dataset

inst: 1.2.840.113619.2.80.1944328678.3740.1437055539.2/?

2015-07-17 15:05:53,669 INFO ALI_SCU->VMP (TCPServer-1-1) [org.dcm4chex.archive.dcm.storescp.StoreScpService] M-WRITE file:/var/lib/dcm4chee-2.17.1-mysql/server/default/archive/2015/7/17/15/5C94E51A/14682371/FDD2E366

2015-07-17 15:05:53,804 INFO ALI_SCU->VMP (TCPServer-1-1) [org.dcm4chex.archive.ejb.session.StorageBean] inserting instance FileMetaInfo[uid=1.2.840.113619.2.80.1944328678.3740.1437055539.2

class=1.2.840.10008.5.1.4.1.1.7/Secondary Capture Image Storage

ts=1.2.840.10008.1.2.4.70/JPEG Lossless, Non- Hierarchical, First-Order Prediction (Process 14 [Selection Value 1])

impl=1.2.40.0.13.1.1.1-dcm4che-1.4.31]

2015-07-17 15:05:53,870 INFO ALI_SCU->VMP (TCPServer-1-1) [org.dcm4chex.archive.ejb.entity.PatientBean] Created Patient[pk=14032, pid=01366990, issuer=null, name=RUMIANOWSKI^MARYMARGARET^^^]

2015-07-17 15:05:53,917 INFO ALI_SCU->VMP (TCPServer-1-1) [org.dcm4chex.archive.ejb.entity.StudyBean] Created Study[pk=15515, uid=1.2.840.113711.9425041.6.8112.458442194.26.2116281012.138300, patient->ejb/Patient:14032]

2015-07-17 15:05:54,101 INFO ALI_SCU->VMP (TCPServer-1-1) [org.dcm4chex.archive.ejb.entity.SeriesRequestBean] Created SeriesRequestAttribute[pk=19655, accno=A11496580, rpid=6682005, spsid=901864, service=null, phys=null, series->ejb/Series:42765]

2015-07-17 15:05:54,101 INFO ALI_SCU->VMP (TCPServer-1-1) [org.dcm4chex.archive.ejb.entity.SeriesBean] Created Series[pk=42765, uid=1.2.840.113619.2.80.1944328678.3740.1437055538.1.5.4, study->ejb/Study:15515]

2015-07-17 15:05:54,194 INFO ALI_SCU->VMP (TCPServer-1-1) [org.dcm4chex.archive.ejb.entity.InstanceBean] Created Instance[pk=851113, iuid=1.2.840.113619.2.80.1944328678.3740.1437055539.2, cuid=1.2.840.10008.5.1.4.1.1.7, series->ejb/Series:42765]

2015-07-17 15:05:54,247 INFO ALI_SCU->VMP (TCPServer-1-1) [org.dcm4chex.archive.ejb.entity.FileBean] Created File[pk=851838, filepath=2015/7/17/15/5C94E51A/14682371/FDD2E366, tsuid=1.2.840.10008.1.2.4.70, filesystem->ejb/FileSystem:1, inst->ejb/Instance:851113]

2015-07-17 15:05:54,301 INFO ALI_SCU->VMP (TCPServer-1-1) [org.dcm4chex.archive.ejb.session.StorageBean] inserted records for instance[uid=1.2.840.113619.2.80.1944328678.3740.1437055539.2]

2015-07-17 15:05:54,320 INFO ALI_SCU->VMP (TCPServer-1-1) [org.dcm4cheri.net.FsmImpl] sending [pc-5] 1:C_STORE_RSP

inst: 1.2.840.113619.2.80.1944328678.3740.1437055539.2/?

status: 0

2015-07-17 15:05:54,858 INFO ALI_SCU->VMP (TCPServer-1-1) [org.dcm4cheri.net.FsmImpl] received [pc-7] 2:C_STORE_RQ with Dataset

inst: 1.2.840.113711.59425041.8.7912.458838501.26.248614862.323/?

2015-07-17 15:05:55,150 INFO ALI_SCU->VMP (TCPServer-1-1) [org.dcm4chex.archive.dcm.storescp.StoreScpService] M-WRITE file:/var/lib/dcm4chee-2.17.1-mysql/server/default/archive/2015/7/17/15/5C94E51A/24AB3102/24AB3123

2015-07-17 15:06:10,371 INFO ALI_SCU->VMP (TCPServer-1-1) [org.dcm4chex.archive.ejb.session.StorageBean] inserting instance FileMetaInfo[uid=1.2.840.113711.59425041.8.7912.458838501.26.248614862.323

class=1.2.840.10008.5.1.4.1.1.88.59/Key Object Selection Document

ts=1.2.840.10008.1.2/Implicit VR Little Endian

impl=1.2.40.0.13.1.1.1-dcm4che-1.4.31]

2015-07-17 15:06:10,395 WARN ALI_SCU->VMP (TCPServer-1-1) [org.dcm4chex.archive.ejb.entity.PatientBean] Coerce null to (0008,0005) Specific Character Set,CS,*1,#10,[ISO_IR 100]

2015-07-17 15:06:10,396 WARN ALI_SCU->VMP (TCPServer-1-1) [org.dcm4chex.archive.ejb.entity.StudyBean] Coerce null to (0008,0005) Specific Character Set,CS,*1,#10,[ISO_IR 100]

2015-07-17 15:06:10,414 INFO ALI_SCU->VMP (TCPServer-1-1) [org.dcm4chex.archive.ejb.entity.SeriesBean] Created Series[pk=42766, uid=1.2.840.113711.59425041.8.7912.458838501.26.248614862.311, study->ejb/Study:15515]

2015-07-17 15:06:10,453 INFO ALI_SCU->VMP (TCPServer-1-1) [org.dcm4chex.archive.ejb.entity.CodeBean] Created Code[pk=156, value=113000, designator=DCM, version=null, meaning=Of Interest]

2015-07-17 15:06:10,453 INFO ALI_SCU->VMP (TCPServer-1-1) [org.dcm4chex.archive.ejb.entity.InstanceBean] Created Instance[pk=851114, iuid=1.2.840.113711.59425041.8.7912.458838501.26.248614862.323, cuid=1.2.840.10008.5.1.4.1.1.88.59, series->ejb/Series:42766]

2015-07-17 15:06:10,466 INFO ALI_SCU->VMP (TCPServer-1-1) [org.dcm4chex.archive.ejb.entity.FileBean] Created File[pk=851839, filepath=2015/7/17/15/5C94E51A/24AB3102/24AB3123, tsuid=1.2.840.10008.1.2, filesystem->ejb/FileSystem:1, inst->ejb/Instance:851114]

2015-07-17 15:06:10,471 INFO ALI_SCU->VMP (TCPServer-1-1) [org.dcm4chex.archive.ejb.session.StorageBean] inserted records for instance[uid=1.2.840.113711.59425041.8.7912.458838501.26.248614862.323]

2015-07-17 15:06:10,481 INFO ALI_SCU->VMP (TCPServer-1-1) [org.dcm4cheri.net.FsmImpl] sending [pc-7] 2:C_STORE_RSP

inst: 1.2.840.113711.59425041.8.7912.458838501.26.248614862.323/?

status: 0

2015-07-17 15:06:10,525 INFO ALI_SCU->VMP (TCPServer-1-1) [org.dcm4cheri.net.FsmImpl] received A-RELEASE-RQ

2015-07-17 15:06:10,525 INFO ALI_SCU->VMP (TCPServer-1-1) [org.dcm4cheri.net.FsmImpl] sending A-RELEASE-RP

2015-07-17 15:06:10,606 INFO ALI_SCU->VMP (TCPServer-1-1) [org.dcm4cheri.net.FsmImpl] closing connection - Socket[addr=/210.10.21.171

,port=3224,localport=11112]

2015-07-17 15:06:10,607 INFO -> (TCPServer-1-1) [org.dcm4cheri.server.ServerImpl] finished - Socket[addr=/210.10.21.171,port=3224,localport=11112]

2015-07-17 15:07:19,704 INFO -> (Thread-260475) [org.dcm4chex.archive.mbean.WadoPrefetchService] Handle SeriesStored Notification! stored:SeriesStored[sourceAET=ALI_SCU, retrieveAET=DCM4CHEE, modality=PT, numOfInst=1, study-iuid=1.2.840.113711.9425041.6.8112.458442194.26.2116281012.138300, series-iuid=1.2.840.113619.2.80.1944328678.3740.1437055538.1.5.4]

2015-07-17 15:07:19,768 INFO -> (Thread-260475) [org.dcm4chex.archive.mbean.WadoPrefetchService] Handle SeriesStored Notification! stored:SeriesStored[sourceAET=ALI_SCU, retrieveAET=DCM4CHEE, modality=KO, numOfInst=1, study-iuid=1.2.840.113711.9425041.6.8112.458442194.26.2116281012.138300, series-iuid=1.2.840.113711.59425041.8.7912.458838501.26.248614862.311]