[Nov 5, 2018 8:17:16 AM] [Transmission 14] The user defined transmission id is set to "--"[Nov 5, 2018 8:17:16 AM] [Transmission 14] Record format of the transmission: U[Nov 5, 2018 8:17:16 AM] [Transmission 14] [Transmission preprocessing]: Unsigned data transmission requested, signature not required[Nov 5, 2018 8:17:16 AM] [Transmission 14] [Transmission preprocessing]: Uncompressed data transmission requested, compression not required[Nov 5, 2018 8:17:16 AM] [Transmission 14] [Transmission preprocessing]: Unencrypted data transmission requested, encryption not required[Nov 5, 2018 8:17:16 AM] [Transmission 14] [Transmission preprocessing]: Unsigned EERP requested, no file hash generation required[Nov 5, 2018 8:17:16 AM] [Transmission 14] Set state from "picked up" to "preprocessed"[Nov 5, 2018 8:17:16 AM] [Transmission 14] Ensured existing target dir "C:\mendelson\opensource\oftp2\messages\ELEKTRA\outbox\pending"[Nov 5, 2018 8:17:16 AM] [Transmission 14] Will move file from "C:\mendelson\opensource\oftp2\temp\20181105\upload_oftp.bin" to "C:\mendelson\opensource\oftp2\messages\ELEKTRA\outbox\pending\NOT-CATEGORIZED201811050817150005"[Nov 5, 2018 8:17:16 AM] [Transmission 14] File move performed[Nov 5, 2018 8:17:16 AM] [Transmission 14] Moved preprocessed data to [C:\mendelson\opensource\oftp2\messages\ELEKTRA\outbox\pending\NOT-CATEGORIZED201811050817150005][Nov 5, 2018 8:17:16 AM] [Transmission 14] Data preprocessing finished successfully, waiting for outbound transmission[Nov 5, 2018 8:17:26 AM] Initializing outgoing connection to ELEKTRA [edi.client.de/213.44.55.66:6619] (TLS)[Nov 5, 2018 8:17:26 AM] [Session 20181105081726-21] Setting session var "Mode" to B[Nov 5, 2018 8:17:26 AM] [Session 20181105081726-21] Setting session var "Restart" to false[Nov 5, 2018 8:17:26 AM] [Session 20181105081726-21] Setting session var "Authentication" to false[Nov 5, 2018 8:17:26 AM] [Session 20181105081726-21] Setting session var "Buf-size" to 2048[Nov 5, 2018 8:17:26 AM] [Session 20181105081726-21] Setting session var "Compression" to false[Nov 5, 2018 8:17:26 AM] [Session 20181105081726-21] Setting session var "Caller" to true[Nov 5, 2018 8:17:26 AM] [Session 20181105081726-21] Setting state machine Session Connection State Machine[Nov 5, 2018 8:17:26 AM] [Session 20181105081726-21] [Session Manager]: Added session with session id 20181105081726-21, created at Nov 5, 2018 8:17:26 AM, remote address is edi.client.de/213.44.55.66:6619[Nov 5, 2018 8:17:26 AM] [Session 20181105081726-21] Session state: I_WF_NC [Initiator Waiting For Network Connection][Nov 5, 2018 8:17:26 AM] [Session 20181105081726-21] Session state: I_WF_NC --> I_WF_RM [Initiator Waiting For Ready Message][Nov 5, 2018 8:17:26 AM] [Session 20181105081726-21] Connection established [edi.client.de/213.44.55.66:6619][Nov 5, 2018 8:17:27 AM] [Session 20181105081726-21] Received stream transmission header (10 00 00 17) indicating 19 following bytes[Nov 5, 2018 8:17:27 AM] [Session 20181105081726-21] Received bytes 49 4f 44 45 54 54 45 20 46 54 50 20 52 45 41 44 59 20 0d[Nov 5, 2018 8:17:27 AM] [Session 20181105081726-21] Received command: o---------------------------------------------------------------- | SSRM Start Session Ready Message [Inbound] o---------------------------------------------------------------- | 0 | X(1) | SSRMCMD | SSRM Command | 'I' | [49] | 1 | X(17) | SSRMMSG | Ready Message | 'ODETTE FTP READY ' | [4f 44 45 54 54 45 20 46 54 50 20 52 45 41 44 59 20] | 18 | X(1) | SSRMCR | Carriage Return | ' ' | [0d] o----------------------------------------------------------------[Nov 5, 2018 8:17:27 AM] [Session 20181105081726-21] Statemachine "Session Connection State Machine" received signal "SSRM", state is "I_WF_RM"[Nov 5, 2018 8:17:27 AM] [Session 20181105081726-21] Session state: I_WF_RM --> I_WF_SSID [Initiator Waiting For SSID][Nov 5, 2018 8:17:27 AM] [Session 20181105081726-21] Send stream transmission header (10 00 00 41)[Nov 5, 2018 8:17:27 AM] [Session 20181105081726-21] Send bytes: 58 35 4f 30 30 31 33 30 30 39 33 30 30 45 4c 45 4b 54 52 41 20 20 20 20 20 20 20 45 4c 53 50 45 4c 20 20 30 32 30 34 38 42 4e 4e 4e 30 39 39 4e 20 20 20 20 20 20 20 20 20 20 20 20 0d[Nov 5, 2018 8:17:27 AM] [Session 20181105081726-21] Send command: o----------------------------------------------------------------------------------------- | SSID Start Session [Outbound] o----------------------------------------------------------------------------------------- | 0 | X(1) | SSIDCMD | SSID Command | 'X' | [58] | 1 | 9(1) | SSIDLEV | Protocol Release Level | '5' | [35] | 2 | X(25) | SSIDCODE | Initiators Identification Code | 'O0013009300ELEKTRA ' | [4f 30 30 31 33 30 30 39 33 30 30 45 4c 45 4b 54 52 41 20 20 20 20 20 20 20] | 27 | X(8) | SSIDPSWD | Initiators Password | 'ELSPEL ' | [45 4c 53 50 45 4c 20 20] | 35 | 9(5) | SSIDSDEB | Data Exchange Buffer Size | '02048' | [30 32 30 34 38] | 40 | X(1) | SSIDSR | Send/Receive Capabilities | 'B' | [42] | 41 | X(1) | SSIDCMPR | Buffer Compression Indicator | 'N' | [4e] | 42 | X(1) | SSIDREST | Restart Indicator | 'N' | [4e] | 43 | X(1) | SSIDSPEC | Special Logic Indicator | 'N' | [4e] | 44 | 9(3) | SSIDCRED | Credit | '099' | [30 39 39] | 47 | X(1) | SSIDAUTH | Secure Authentication | 'N' | [4e] | 48 | X(4) | SSIDRSV1 | Reserved | ' ' | [20 20 20 20] | 52 | X(8) | SSIDUSER | User Data | ' ' | [20 20 20 20 20 20 20 20] | 60 | X(1) | SSIDCR | Carriage Return | ' ' | [0d] o-----------------------------------------------------------------------------------------[Nov 5, 2018 8:17:32 AM] [Session 20181105081726-21] Received stream transmission header (10 00 00 07) indicating 3 following bytes[Nov 5, 2018 8:17:32 AM] [Session 20181105081726-21] Received bytes 46 30 33[Nov 5, 2018 8:17:32 AM] A processing problem occured. This could have several reasons, for further information please have a look at "C:\mendelson\opensource\oftp2\log\20181105\systemactivity.log".[Nov 5, 2018 8:17:32 AM] [Session 20181105081726-21] java.lang.RuntimeException: The system is unable to parse the inbound OFTP2 command "ESID" (The received OFTP2 protocol command data is to short). This is not a problem of your mendelson OFTP2 system. It is a protocol violation performed by your partners OFTP2 system. It looks as if your partner is using a OFTP 1.x system or falls back to the OFTP1 protocol in an error case. If this problem happens during the connection attempt please check if you have transmitted the right connection password. Please also check your secure authentication challenge settings. Please also contact your partner to clarify this issue. (Hexdump: 10 00 00 07 46 30 33)[Nov 5, 2018 8:17:32 AM] [Session 20181105081726-21] [Session Manager]: Removed session 20181105081726-21 with partner null, created at Nov 5, 2018 8:17:26 AM, remote address was edi.client.de/213.44.55.66:6619[Nov 5, 2018 8:17:32 AM] [Session 20181105081726-21] Connection closed [POL-ELEKTRA - ELEKTRA, edi.client.de/213.44.55.66:6619]. Established for 6.4s, 2962 bytes transfered [Nov 5, 2018 8:20:17 AM] [Session 20181105082017-22] Setting state machine Session Connection State Machine[Nov 5, 2018 8:20:17 AM] [Session 20181105082017-22] [Session Manager]: Added session with session id 20181105082017-22, created at Nov 5, 2018 8:20:17 AM, remote address is /192.168.0.210:56850[Nov 5, 2018 8:20:17 AM] [Session 20181105082017-22] Incoming connection [/192.168.0.210:56850][Nov 5, 2018 8:20:17 AM] [Session 20181105082017-22] Setting session var "Caller" to false[Nov 5, 2018 8:20:17 AM] [Session 20181105082017-22] Session state: IDLE [Idle][Nov 5, 2018 8:20:17 AM] [Session 20181105082017-22] Statemachine "Session Connection State Machine" received signal "N_CON_IND", state is "IDLE"[Nov 5, 2018 8:20:17 AM] [Session 20181105082017-22] Processing unit received signal "N_CON_RS", state is "IDLE"[Nov 5, 2018 8:20:17 AM] [Session 20181105082017-22] Send stream transmission header (10 00 00 17)[Nov 5, 2018 8:20:17 AM] [Session 20181105082017-22] Send bytes: 49 4f 44 45 54 54 45 20 46 54 50 20 52 45 41 44 59 20 0d[Nov 5, 2018 8:20:17 AM] [Session 20181105082017-22] Send command: o----------------------------------------------------------------- | SSRM Start Session Ready Message [Outbound] o----------------------------------------------------------------- | 0 | X(1) | SSRMCMD | SSRM Command | 'I' | [49] | 1 | X(17) | SSRMMSG | Ready Message | 'ODETTE FTP READY ' | [4f 44 45 54 54 45 20 46 54 50 20 52 45 41 44 59 20] | 18 | X(1) | SSRMCR | Carriage Return | ' ' | [0d] o-----------------------------------------------------------------[Nov 5, 2018 8:20:17 AM] [Session 20181105082017-22] Session state: IDLE --> A_NC_ONLY [Responder, Network Connection Opened][Nov 5, 2018 8:21:02 AM] [Session 20181105082017-22] Session timeout [POL-ELEKTRA - --][Nov 5, 2018 8:21:02 AM] [Session 20181105082017-22] [Session Manager]: Removed session 20181105082017-22 with partner null, created at Nov 5, 2018 8:20:17 AM, remote address was /192.168.0.210:56850[Nov 5, 2018 8:21:02 AM] [Session 20181105082017-22] Connection closed [POL-ELEKTRA - --, /192.168.0.210:56850]. Established for 45.2s, 0 bytes transfered