[
https://issues.apache.org/jira/browse/NIFI-10846?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=17676252#comment-17676252
]
Florent commented on NIFI-10846:
--------------------------------
Hello [~turcsanyip]
My environment is :
* Docker Nifi 1.19.1 (Official), Java embedded
* Docker-ce : docker-ce-20.10.18-3.el7.x86_64
* OS: RHEL 7.9
So i make some tests with the GetSmbFile Processor on version 1.17.0 and 1.19.1
on the same Nifi, you will see on log file :
* Version 1.17.0 at 2023-01-12 15:42:55,596
* Version 1.19.1 at 2023-01-12 15:43:05,668
on 1.17 the SMB protocol negociated is SMB_2_1 without packet encryption and on
1.19 it used SMB_3_1_1 with packet encryption on Cipher AES_128_GCM
!getsmb_error.png!
{code:java}
### GetSmbFile VERSION 1.17.0
2023-01-12 15:42:55,596 INFO [NiFi Web Server-23]
o.a.n.c.s.StandardProcessScheduler Running once
GetSmbFile[id=25d0ad30-ccdd-3d4b-67ff-043710c45ae7]
2023-01-12 15:42:55,596 INFO [NiFi Web Server-23]
o.a.n.controller.StandardProcessorNode Starting
GetSmbFile[id=25d0ad30-ccdd-3d4b-67ff-043710c45ae7]
2023-01-12 15:42:55,667 INFO [NiFi Web Server-23]
org.apache.nifi.web.server.RequestLog 192.168.1.128 - florent
[12/Jan/2023:15:42:55 +0000] "PUT
/nifi-api/processors/25d0ad30-ccdd-3d4b-67ff-043710c45ae7/run-status HTTP/1.1"
200 2317
"https://nifi-test.sanbox.net:9447/nifi/?processGroupId=08be022a-aa63-3a5e-8a22-5f0041cc89de&componentIds=25d0ad30-ccdd-3d4b-67ff-043710c45ae7";
"Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like
Gecko) Chrome/91.0.4472.124 Safari/537.36"
2023-01-12 15:42:55,690 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.transport.PacketReader Starting PacketReader on thread:
Packet Reader for 10.10.2.19
2023-01-12 15:42:55,692 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection Negotiating dialects [SMB_2_0_2,
SMB_2_1] with server 10.10.2.19
2023-01-12 15:42:55,693 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection Granted 1 (out of 1) credits to
SMB2_NEGOTIATE with message id << 0 >>
2023-01-12 15:42:55,696 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
SMB2_NEGOTIATE with message id << 0 >> >>
2023-01-12 15:42:55,696 DEBUG [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet SMB2_NEGOTIATE with
message id << 0 >>
2023-01-12 15:42:55,699 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Packet SMB2_NEGOTIATE with message id <<
0 >> sent, lock released.
2023-01-12 15:42:55,702 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.transport.PacketReader Received packet
com.hierynomus.mssmb2.SMB2PacketData@5a5e6131
2023-01-12 15:42:55,702 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Server granted us 1 credits for
com.hierynomus.mssmb2.SMB2PacketData@5a5e6131, now available: 1 credits
2023-01-12 15:42:55,702 TRACE [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Send/Recv of packet
com.hierynomus.mssmb2.SMB2PacketData@5a5e6131 took << 8 ms >>
2023-01-12 15:42:55,707 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection Negotiated the following connection
settings: ConnectionInfo{
serverGuid=d264fe60-8f3c-4f60-b2c1-e0915c1e1958,
serverName='10.10.2.19',
negotiatedProtocol=NegotiatedProtocol{dialect=SMB_2_1, maxTransactSize=65536,
maxReadSize=1048576, maxWriteSize=1048576},
clientGuid=8dc91d83-28f3-4f68-b3b3-a87c828ad238,
clientCapabilities=[SMB2_GLOBAL_CAP_DFS],
serverCapabilities=[SMB2_GLOBAL_CAP_DFS, SMB2_GLOBAL_CAP_LEASING,
SMB2_GLOBAL_CAP_LARGE_MTU],
clientSecurityMode=0,
serverSecurityMode=1,
server='null'
}
2023-01-12 15:42:55,707 INFO [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection Successfully connected to: 10.10.2.19
2023-01-12 15:42:55,727 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.auth.NtlmAuthenticator Initialized Authentication of florent
using NTLM
2023-01-12 15:42:55,733 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection Granted 1 (out of 1) credits to
SMB2_SESSION_SETUP with message id << 1 >>
2023-01-12 15:42:55,733 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
SMB2_SESSION_SETUP with message id << 1 >> >>
2023-01-12 15:42:55,733 DEBUG [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet SMB2_SESSION_SETUP with
message id << 1 >>
2023-01-12 15:42:55,733 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Packet SMB2_SESSION_SETUP with message id
<< 1 >> sent, lock released.
2023-01-12 15:42:55,738 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.transport.PacketReader Received packet
com.hierynomus.mssmb2.SMB2PacketData@7509d6be
2023-01-12 15:42:55,738 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Server granted us 128 credits for
com.hierynomus.mssmb2.SMB2PacketData@7509d6be, now available: 128 credits
2023-01-12 15:42:55,738 TRACE [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Send/Recv of packet
com.hierynomus.mssmb2.SMB2PacketData@7509d6be took << 5 ms >>
2023-01-12 15:42:55,739 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection More processing required for
authentication of florent using
com.hierynomus.smbj.auth.NtlmAuthenticator@d82cbdc
2023-01-12 15:42:55,739 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.auth.NtlmAuthenticator Received token: a1 82 01 05 30 82 01
01 a0 82 00 03 0a 01 01 a1 82 00 0c 06 0a 2b 06 01 04 01 82 37 02 02 0a a2 82
00 e6 04 82 00 e2 4e 54 4c 4d 53 53 50 00 02 00 00 00 1c 00 1c 00 30 00 00 00
15 82 89 60 7e f9 65 93 0e 70 9f 17 00 00 00 00 00 00 00 00 96 00 96 00 4c 00
00 00 44 00 41 00 53 00 53 00 41 00 55 00 4c 00 54 00 2d 00 41 00 56 00 49 00
4f 00 4e 00 01 00 10 00 44 00 41 00 46 00 30 00 39 00 38 00 50 00 31 00 02 00
1c 00 44 00 41 00 53 00 53 00 41 00 55 00 4c 00 54 00 2d 00 41 00 56 00 49 00
4f 00 4e 00 03 00 34 00 44 00 41 00 46 00 30 00 39 00 38 00 50 00 31 00 2e 00
44 00 41 00 53 00 53 00 41 00 55 00 4c 00 54 00 2d 00 41 00 56 00 49 00 4f 00
4e 00 2e 00 46 00 52 00 04 00 22 00 44 00 41 00 53 00 53 00 41 00 55 00 4c 00
54 00 2d 00 41 00 56 00 49 00 4f 00 4e 00 2e 00 46 00 52 00 00 00 00 00
2023-01-12 15:42:55,746 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.auth.NtlmAuthenticator Received NTLM challenge from:
SANDBOX-DOMAIN
2023-01-12 15:42:55,751 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection Granted 1 (out of 128) credits to
SMB2_SESSION_SETUP with message id << 2 >>
2023-01-12 15:42:55,751 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
SMB2_SESSION_SETUP with message id << 2 >> >>
2023-01-12 15:42:55,751 DEBUG [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet SMB2_SESSION_SETUP with
message id << 2 >>
2023-01-12 15:42:55,751 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Packet SMB2_SESSION_SETUP with message id
<< 2 >> sent, lock released.
2023-01-12 15:42:55,775 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.transport.PacketReader Received packet
com.hierynomus.mssmb2.SMB2PacketData@2467d61c
2023-01-12 15:42:55,775 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Server granted us 1 credits for
com.hierynomus.mssmb2.SMB2PacketData@2467d61c, now available: 128 credits
2023-01-12 15:42:55,775 TRACE [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Send/Recv of packet
com.hierynomus.mssmb2.SMB2PacketData@2467d61c took << 24 ms >>
2023-01-12 15:42:55,775 INFO [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection Successfully authenticated florent on
10.10.2.19, session is -6929069501598539297
2023-01-12 15:42:55,776 INFO [Timer-Driven Process Thread-2]
com.hierynomus.smbj.session.Session Connecting to \\10.10.2.19\HOMES on session
-6929069501598539297
2023-01-12 15:42:55,776 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection Granted 1 (out of 128) credits to
SMB2_TREE_CONNECT with message id << 3 >>
2023-01-12 15:42:55,776 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
SMB2_TREE_CONNECT with message id << 3 >> >>
2023-01-12 15:42:55,776 DEBUG [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet SMB2_TREE_CONNECT with
message id << 3 >>
2023-01-12 15:42:55,777 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Packet SMB2_TREE_CONNECT with message id
<< 3 >> sent, lock released.
2023-01-12 15:42:55,778 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.transport.PacketReader Received packet
com.hierynomus.mssmb2.SMB2PacketData@3ab12cf6
2023-01-12 15:42:55,778 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Server granted us 1 credits for
com.hierynomus.mssmb2.SMB2PacketData@3ab12cf6, now available: 128 credits
2023-01-12 15:42:55,778 TRACE [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Send/Recv of packet
com.hierynomus.mssmb2.SMB2PacketData@3ab12cf6 took << 2 ms >>
2023-01-12 15:42:55,786 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection Granted 1 (out of 128) credits to
SMB2_CREATE with message id << 4 >>
2023-01-12 15:42:55,786 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
SMB2_CREATE with message id << 4 >> >>
2023-01-12 15:42:55,786 DEBUG [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet SMB2_CREATE with message
id << 4 >>
2023-01-12 15:42:55,787 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Packet SMB2_CREATE with message id << 4
>> sent, lock released.
2023-01-12 15:42:55,787 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.transport.PacketReader Received packet
com.hierynomus.mssmb2.SMB2PacketData@16a944d7
2023-01-12 15:42:55,787 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Server granted us 1 credits for
com.hierynomus.mssmb2.SMB2PacketData@16a944d7, now available: 128 credits
2023-01-12 15:42:55,787 TRACE [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Send/Recv of packet
com.hierynomus.mssmb2.SMB2PacketData@16a944d7 took << 1 ms >>
2023-01-12 15:42:55,788 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection Granted 1 (out of 128) credits to
SMB2_CLOSE with message id << 5 >>
2023-01-12 15:42:55,789 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
SMB2_CLOSE with message id << 5 >> >>
2023-01-12 15:42:55,789 DEBUG [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet SMB2_CLOSE with message id
<< 5 >>
2023-01-12 15:42:55,789 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Packet SMB2_CLOSE with message id << 5 >>
sent, lock released.
2023-01-12 15:42:55,789 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.transport.PacketReader Received packet
com.hierynomus.mssmb2.SMB2PacketData@39bbaf27
2023-01-12 15:42:55,789 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Server granted us 1 credits for
com.hierynomus.mssmb2.SMB2PacketData@39bbaf27, now available: 128 credits
2023-01-12 15:42:55,789 TRACE [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Send/Recv of packet
com.hierynomus.mssmb2.SMB2PacketData@39bbaf27 took << 0 ms >>
2023-01-12 15:42:55,790 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection Granted 1 (out of 128) credits to
SMB2_CREATE with message id << 6 >>
2023-01-12 15:42:55,790 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
SMB2_CREATE with message id << 6 >> >>
2023-01-12 15:42:55,790 DEBUG [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet SMB2_CREATE with message
id << 6 >>
2023-01-12 15:42:55,790 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Packet SMB2_CREATE with message id << 6
>> sent, lock released.
2023-01-12 15:42:55,790 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.transport.PacketReader Received packet
com.hierynomus.mssmb2.SMB2PacketData@43f07686
2023-01-12 15:42:55,790 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Server granted us 1 credits for
com.hierynomus.mssmb2.SMB2PacketData@43f07686, now available: 128 credits
2023-01-12 15:42:55,790 TRACE [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Send/Recv of packet
com.hierynomus.mssmb2.SMB2PacketData@43f07686 took << 0 ms >>
2023-01-12 15:42:55,800 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection Granted 1 (out of 128) credits to
SMB2_QUERY_DIRECTORY with message id << 7 >>
2023-01-12 15:42:55,800 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
SMB2_QUERY_DIRECTORY with message id << 7 >> >>
2023-01-12 15:42:55,800 DEBUG [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet SMB2_QUERY_DIRECTORY with
message id << 7 >>
2023-01-12 15:42:55,800 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Packet SMB2_QUERY_DIRECTORY with message
id << 7 >> sent, lock released.
2023-01-12 15:42:55,800 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.transport.PacketReader Received packet
com.hierynomus.mssmb2.SMB2PacketData@1954d45
2023-01-12 15:42:55,800 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Server granted us 1 credits for
com.hierynomus.mssmb2.SMB2PacketData@1954d45, now available: 128 credits
2023-01-12 15:42:55,801 TRACE [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Send/Recv of packet
com.hierynomus.mssmb2.SMB2PacketData@1954d45 took << 1 ms >>
2023-01-12 15:42:55,802 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection Granted 1 (out of 128) credits to
SMB2_QUERY_DIRECTORY with message id << 8 >>
2023-01-12 15:42:55,803 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
SMB2_QUERY_DIRECTORY with message id << 8 >> >>
2023-01-12 15:42:55,803 DEBUG [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet SMB2_QUERY_DIRECTORY with
message id << 8 >>
2023-01-12 15:42:55,803 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Packet SMB2_QUERY_DIRECTORY with message
id << 8 >> sent, lock released.
2023-01-12 15:42:55,804 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.transport.PacketReader Received packet
com.hierynomus.mssmb2.SMB2PacketData@600fc43d
2023-01-12 15:42:55,804 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Server granted us 1 credits for
com.hierynomus.mssmb2.SMB2PacketData@600fc43d, now available: 128 credits
2023-01-12 15:42:55,804 TRACE [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Send/Recv of packet
com.hierynomus.mssmb2.SMB2PacketData@600fc43d took << 1 ms >>
2023-01-12 15:42:55,805 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection Granted 1 (out of 128) credits to
SMB2_CLOSE with message id << 9 >>
2023-01-12 15:42:55,805 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
SMB2_CLOSE with message id << 9 >> >>
2023-01-12 15:42:55,805 DEBUG [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet SMB2_CLOSE with message id
<< 9 >>
2023-01-12 15:42:55,805 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Packet SMB2_CLOSE with message id << 9 >>
sent, lock released.
2023-01-12 15:42:55,805 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.transport.PacketReader Received packet
com.hierynomus.mssmb2.SMB2PacketData@5d06af18
2023-01-12 15:42:55,805 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Server granted us 1 credits for
com.hierynomus.mssmb2.SMB2PacketData@5d06af18, now available: 128 credits
2023-01-12 15:42:55,805 TRACE [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Send/Recv of packet
com.hierynomus.mssmb2.SMB2PacketData@5d06af18 took << 0 ms >>
2023-01-12 15:42:55,810 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection Granted 1 (out of 128) credits to
SMB2_CREATE with message id << 10 >>
2023-01-12 15:42:55,810 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
SMB2_CREATE with message id << 10 >> >>
2023-01-12 15:42:55,810 DEBUG [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet SMB2_CREATE with message
id << 10 >>
2023-01-12 15:42:55,810 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Packet SMB2_CREATE with message id << 10
>> sent, lock released.
2023-01-12 15:42:55,811 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.transport.PacketReader Received packet
com.hierynomus.mssmb2.SMB2PacketData@2324c26e
2023-01-12 15:42:55,811 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Server granted us 1 credits for
com.hierynomus.mssmb2.SMB2PacketData@2324c26e, now available: 128 credits
2023-01-12 15:42:55,811 TRACE [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Send/Recv of packet
com.hierynomus.mssmb2.SMB2PacketData@2324c26e took << 1 ms >>
2023-01-12 15:42:55,818 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection Granted 16 (out of 128) credits to
SMB2_READ with message id << 11 >>
2023-01-12 15:42:55,818 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
SMB2_READ with message id << 11 >> >>
2023-01-12 15:42:55,818 DEBUG [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet SMB2_READ with message id
<< 11 >>
2023-01-12 15:42:55,818 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Packet SMB2_READ with message id << 11 >>
sent, lock released.
2023-01-12 15:42:55,819 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.transport.PacketReader Received packet
com.hierynomus.mssmb2.SMB2PacketData@4cd15c63
2023-01-12 15:42:55,819 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Server granted us 16 credits for
com.hierynomus.mssmb2.SMB2PacketData@4cd15c63, now available: 128 credits
2023-01-12 15:42:55,819 TRACE [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Send/Recv of packet
com.hierynomus.mssmb2.SMB2PacketData@4cd15c63 took << 1 ms >>
2023-01-12 15:42:55,819 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection Granted 16 (out of 128) credits to
SMB2_READ with message id << 27 >>
2023-01-12 15:42:55,819 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
SMB2_READ with message id << 27 >> >>
2023-01-12 15:42:55,819 DEBUG [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet SMB2_READ with message id
<< 27 >>
2023-01-12 15:42:55,819 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Packet SMB2_READ with message id << 27 >>
sent, lock released.
2023-01-12 15:42:55,819 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.transport.PacketReader Received packet
com.hierynomus.mssmb2.SMB2PacketData@7b66b529
2023-01-12 15:42:55,819 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Server granted us 16 credits for
com.hierynomus.mssmb2.SMB2PacketData@7b66b529, now available: 128 credits
2023-01-12 15:42:55,820 TRACE [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Send/Recv of packet
com.hierynomus.mssmb2.SMB2PacketData@7b66b529 took << 1 ms >>
2023-01-12 15:42:55,820 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.share.FileInputStream EOF, 7038 bytes read
2023-01-12 15:42:55,821 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection Granted 1 (out of 128) credits to
SMB2_QUERY_INFO with message id << 43 >>
2023-01-12 15:42:55,821 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
SMB2_QUERY_INFO with message id << 43 >> >>
2023-01-12 15:42:55,821 DEBUG [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet SMB2_QUERY_INFO with
message id << 43 >>
2023-01-12 15:42:55,822 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Packet SMB2_QUERY_INFO with message id <<
43 >> sent, lock released.
2023-01-12 15:42:55,822 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.transport.PacketReader Received packet
com.hierynomus.mssmb2.SMB2PacketData@65731870
2023-01-12 15:42:55,822 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Server granted us 1 credits for
com.hierynomus.mssmb2.SMB2PacketData@65731870, now available: 128 credits
2023-01-12 15:42:55,822 TRACE [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Send/Recv of packet
com.hierynomus.mssmb2.SMB2PacketData@65731870 took << 1 ms >>
2023-01-12 15:42:55,823 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection Granted 1 (out of 128) credits to
SMB2_CLOSE with message id << 44 >>
2023-01-12 15:42:55,824 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
SMB2_CLOSE with message id << 44 >> >>
2023-01-12 15:42:55,824 DEBUG [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet SMB2_CLOSE with message id
<< 44 >>
2023-01-12 15:42:55,824 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Packet SMB2_CLOSE with message id << 44
>> sent, lock released.
2023-01-12 15:42:55,824 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.transport.PacketReader Received packet
com.hierynomus.mssmb2.SMB2PacketData@7432ec54
2023-01-12 15:42:55,824 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Server granted us 1 credits for
com.hierynomus.mssmb2.SMB2PacketData@7432ec54, now available: 128 credits
2023-01-12 15:42:55,824 TRACE [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Send/Recv of packet
com.hierynomus.mssmb2.SMB2PacketData@7432ec54 took << 0 ms >>
2023-01-12 15:42:55,825 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection Granted 1 (out of 128) credits to
SMB2_CREATE with message id << 45 >>
2023-01-12 15:42:55,825 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
SMB2_CREATE with message id << 45 >> >>
2023-01-12 15:42:55,825 DEBUG [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet SMB2_CREATE with message
id << 45 >>
2023-01-12 15:42:55,825 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Packet SMB2_CREATE with message id << 45
>> sent, lock released.
2023-01-12 15:42:55,826 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.transport.PacketReader Received packet
com.hierynomus.mssmb2.SMB2PacketData@3ab3d006
2023-01-12 15:42:55,826 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Server granted us 1 credits for
com.hierynomus.mssmb2.SMB2PacketData@3ab3d006, now available: 128 credits
2023-01-12 15:42:55,826 TRACE [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Send/Recv of packet
com.hierynomus.mssmb2.SMB2PacketData@3ab3d006 took << 1 ms >>
2023-01-12 15:42:55,826 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection Granted 16 (out of 128) credits to
SMB2_READ with message id << 46 >>
2023-01-12 15:42:55,826 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
SMB2_READ with message id << 46 >> >>
2023-01-12 15:42:55,826 DEBUG [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet SMB2_READ with message id
<< 46 >>
2023-01-12 15:42:55,826 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Packet SMB2_READ with message id << 46 >>
sent, lock released.
2023-01-12 15:42:55,827 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.transport.PacketReader Received packet
com.hierynomus.mssmb2.SMB2PacketData@47feffb8
2023-01-12 15:42:55,827 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Server granted us 16 credits for
com.hierynomus.mssmb2.SMB2PacketData@47feffb8, now available: 128 credits
2023-01-12 15:42:55,827 TRACE [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Send/Recv of packet
com.hierynomus.mssmb2.SMB2PacketData@47feffb8 took << 1 ms >>
2023-01-12 15:42:55,828 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection Granted 16 (out of 128) credits to
SMB2_READ with message id << 62 >>
2023-01-12 15:42:55,828 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
SMB2_READ with message id << 62 >> >>
2023-01-12 15:42:55,828 DEBUG [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet SMB2_READ with message id
<< 62 >>
2023-01-12 15:42:55,828 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Packet SMB2_READ with message id << 62 >>
sent, lock released.
2023-01-12 15:42:55,829 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.transport.PacketReader Received packet
com.hierynomus.mssmb2.SMB2PacketData@5ff65d14
2023-01-12 15:42:55,829 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Server granted us 16 credits for
com.hierynomus.mssmb2.SMB2PacketData@5ff65d14, now available: 128 credits
2023-01-12 15:42:55,829 TRACE [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Send/Recv of packet
com.hierynomus.mssmb2.SMB2PacketData@5ff65d14 took << 1 ms >>
2023-01-12 15:42:55,829 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.share.FileInputStream EOF, 9598 bytes read
2023-01-12 15:42:55,829 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection Granted 1 (out of 128) credits to
SMB2_QUERY_INFO with message id << 78 >>
2023-01-12 15:42:55,829 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
SMB2_QUERY_INFO with message id << 78 >> >>
2023-01-12 15:42:55,829 DEBUG [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet SMB2_QUERY_INFO with
message id << 78 >>
2023-01-12 15:42:55,829 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Packet SMB2_QUERY_INFO with message id <<
78 >> sent, lock released.
2023-01-12 15:42:55,829 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.transport.PacketReader Received packet
com.hierynomus.mssmb2.SMB2PacketData@3c455af2
2023-01-12 15:42:55,829 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Server granted us 1 credits for
com.hierynomus.mssmb2.SMB2PacketData@3c455af2, now available: 128 credits
2023-01-12 15:42:55,829 TRACE [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Send/Recv of packet
com.hierynomus.mssmb2.SMB2PacketData@3c455af2 took << 0 ms >>
2023-01-12 15:42:55,830 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection Granted 1 (out of 128) credits to
SMB2_CLOSE with message id << 79 >>
2023-01-12 15:42:55,830 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
SMB2_CLOSE with message id << 79 >> >>
2023-01-12 15:42:55,830 DEBUG [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet SMB2_CLOSE with message id
<< 79 >>
2023-01-12 15:42:55,830 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Packet SMB2_CLOSE with message id << 79
>> sent, lock released.
2023-01-12 15:42:55,830 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.transport.PacketReader Received packet
com.hierynomus.mssmb2.SMB2PacketData@18d28e9c
2023-01-12 15:42:55,830 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Server granted us 1 credits for
com.hierynomus.mssmb2.SMB2PacketData@18d28e9c, now available: 128 credits
2023-01-12 15:42:55,830 TRACE [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Send/Recv of packet
com.hierynomus.mssmb2.SMB2PacketData@18d28e9c took << 0 ms >>
2023-01-12 15:42:55,862 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection Granted 1 (out of 128) credits to
SMB2_TREE_DISCONNECT with message id << 80 >>
2023-01-12 15:42:55,862 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
SMB2_TREE_DISCONNECT with message id << 80 >> >>
2023-01-12 15:42:55,862 DEBUG [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet SMB2_TREE_DISCONNECT with
message id << 80 >>
2023-01-12 15:42:55,862 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Packet SMB2_TREE_DISCONNECT with message
id << 80 >> sent, lock released.
2023-01-12 15:42:55,862 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.transport.PacketReader Received packet
com.hierynomus.mssmb2.SMB2PacketData@28e1a101
2023-01-12 15:42:55,862 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Server granted us 1 credits for
com.hierynomus.mssmb2.SMB2PacketData@28e1a101, now available: 128 credits
2023-01-12 15:42:55,862 TRACE [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Send/Recv of packet
com.hierynomus.mssmb2.SMB2PacketData@28e1a101 took << 0 ms >>
2023-01-12 15:42:55,864 DEBUG [Timer-Driven Process Thread-2]
com.hierynomus.smbj.session.Session Notified of TreeDisconnected <<1>>
2023-01-12 15:42:55,864 INFO [Timer-Driven Process Thread-2]
com.hierynomus.smbj.session.Session Logging off session -6929069501598539297
from host 10.10.2.19
2023-01-12 15:42:55,864 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection Granted 1 (out of 128) credits to
SMB2_LOGOFF with message id << 81 >>
2023-01-12 15:42:55,864 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
SMB2_LOGOFF with message id << 81 >> >>
2023-01-12 15:42:55,864 DEBUG [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet SMB2_LOGOFF with message
id << 81 >>
2023-01-12 15:42:55,864 TRACE [Timer-Driven Process Thread-2]
c.h.s.t.tcp.direct.DirectTcpTransport Packet SMB2_LOGOFF with message id << 81
>> sent, lock released.
2023-01-12 15:42:55,865 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.transport.PacketReader Received packet
com.hierynomus.mssmb2.SMB2PacketData@459257f4
2023-01-12 15:42:55,865 DEBUG [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Server granted us 1 credits for
com.hierynomus.mssmb2.SMB2PacketData@459257f4, now available: 128 credits
2023-01-12 15:42:55,865 TRACE [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.connection.Connection Send/Recv of packet
com.hierynomus.mssmb2.SMB2PacketData@459257f4 took << 1 ms >>
2023-01-12 15:42:55,865 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection Session << -6929069501598539297 >>
logged off
2023-01-12 15:42:55,865 DEBUG [Timer-Driven Process Thread-2]
c.hierynomus.smbj.transport.PacketReader Stopping PacketReader...
2023-01-12 15:42:55,865 INFO [Timer-Driven Process Thread-2]
c.hierynomus.smbj.connection.Connection Closed connection to 10.10.2.19
2023-01-12 15:42:55,865 DEBUG [Timer-Driven Process Thread-2]
com.hierynomus.smbj.SMBClient Connection to << 10.10.2.19:445 >> closed
2023-01-12 15:42:55,866 INFO [Timer-Driven Process Thread-2]
o.a.n.c.s.StandardProcessScheduler Stopping
GetSmbFile[id=25d0ad30-ccdd-3d4b-67ff-043710c45ae7]
2023-01-12 15:42:55,866 INFO [Timer-Driven Process Thread-2]
o.a.n.controller.StandardProcessorNode Stopping processor:
GetSmbFile[id=25d0ad30-ccdd-3d4b-67ff-043710c45ae7]
2023-01-12 15:42:55,867 INFO [Timer-Driven Process Thread-2]
o.a.n.c.s.TimerDrivenSchedulingAgent Stopped scheduling
GetSmbFile[id=25d0ad30-ccdd-3d4b-67ff-043710c45ae7] to run
2023-01-12 15:42:55,867 INFO [Timer-Driven Process Thread-2]
o.a.n.controller.StandardProcessorNode
GetSmbFile[id=25d0ad30-ccdd-3d4b-67ff-043710c45ae7] has completely stopped.
Completing any associated Futures.
2023-01-12 15:42:55,868 INFO [Packet Reader for 10.10.2.19]
c.hierynomus.smbj.transport.PacketReader Thread[Packet Reader for
10.10.2.19,5,main] stopped.
2023-01-12 15:42:55,931 INFO [NiFi Web Server-23]
org.apache.nifi.web.server.RequestLog 192.168.1.128 - florent
[12/Jan/2023:15:42:55 +0000] "GET /nifi-api/flow/status HTTP/1.1" 200 215
"https://nifi-test.sanbox.net:9447/nifi/?processGroupId=08be022a-aa63-3a5e-8a22-5f0041cc89de&componentIds=25d0ad30-ccdd-3d4b-67ff-043710c45ae7";
"Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like
Gecko) Chrome/91.0.4472.124 Safari/537.36"
2023-01-12 15:42:55,938 INFO [NiFi Web Server-18]
org.apache.nifi.web.server.RequestLog 192.168.1.128 - florent
[12/Jan/2023:15:42:55 +0000] "GET /nifi-api/flow/current-user HTTP/1.1" 200 383
"https://nifi-test.sanbox.net:9447/nifi/?processGroupId=08be022a-aa63-3a5e-8a22-5f0041cc89de&componentIds=25d0ad30-ccdd-3d4b-67ff-043710c45ae7";
"Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like
Gecko) Chrome/91.0.4472.124 Safari/537.36"
2023-01-12 15:42:55,939 INFO [Flow Service Tasks Thread-1]
o.a.nifi.controller.StandardFlowService Saved flow controller
org.apache.nifi.controller.FlowController@49d2f500 // Another save pending =
false
2023-01-12 15:42:55,943 INFO [NiFi Web Server-21]
org.apache.nifi.web.server.RequestLog 192.168.1.128 - florent
[12/Jan/2023:15:42:55 +0000] "GET /nifi-api/flow/controller/bulletins HTTP/1.1"
200 109
"https://nifi-test.sanbox.net:9447/nifi/?processGroupId=08be022a-aa63-3a5e-8a22-5f0041cc89de&componentIds=25d0ad30-ccdd-3d4b-67ff-043710c45ae7";
"Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like
Gecko) Chrome/91.0.4472.124 Safari/537.36"
2023-01-12 15:42:55,947 INFO [NiFi Web Server-22]
org.apache.nifi.web.server.RequestLog 192.168.1.128 - florent
[12/Jan/2023:15:42:55 +0000] "GET
/nifi-api/flow/process-groups/08be022a-aa63-3a5e-8a22-5f0041cc89de?uiOnly=true
HTTP/1.1" 200 2252
"https://nifi-test.sanbox.net:9447/nifi/?processGroupId=08be022a-aa63-3a5e-8a22-5f0041cc89de&componentIds=25d0ad30-ccdd-3d4b-67ff-043710c45ae7";
"Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like
Gecko) Chrome/91.0.4472.124 Safari/537.36"
2023-01-12 15:42:55,948 INFO [NiFi Web Server-83]
org.apache.nifi.web.server.RequestLog 192.168.1.128 - florent
[12/Jan/2023:15:42:55 +0000] "GET /nifi-api/flow/cluster/summary HTTP/1.1" 200
92
"https://nifi-test.sanbox.net:9447/nifi/?processGroupId=08be022a-aa63-3a5e-8a22-5f0041cc89de&componentIds=25d0ad30-ccdd-3d4b-67ff-043710c45ae7";
"Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like
Gecko) Chrome/91.0.4472.124 Safari/537.36"### GetSmbFile VERSION 1.19.1
2023-01-12 15:43:05,668 INFO [pool-7-thread-1]
o.a.n.c.r.WriteAheadFlowFileRepository Initiating checkpoint of FlowFile
Repository
2023-01-12 15:43:05,676 INFO [pool-7-thread-1]
o.a.n.wali.SequentialAccessWriteAheadLog Checkpointed Write-Ahead Log with 2
Records and 0 Swap Files in 7 milliseconds (Stop-the-world time = 0
milliseconds), max Transaction ID 133953726
2023-01-12 15:43:05,676 INFO [pool-7-thread-1]
o.a.n.c.r.WriteAheadFlowFileRepository Successfully checkpointed FlowFile
Repository with 2 records in 7 milliseconds
2023-01-12 15:43:15,037 INFO [NiFi Web Server-25]
o.a.n.c.s.StandardProcessScheduler Running once
GetSmbFile[id=ccdd3d4b-ad30-15d0-df43-453a1016b592]
2023-01-12 15:43:15,038 INFO [NiFi Web Server-25]
o.a.n.controller.StandardProcessorNode Starting
GetSmbFile[id=ccdd3d4b-ad30-15d0-df43-453a1016b592]
2023-01-12 15:43:15,056 INFO [NiFi Web Server-25]
org.apache.nifi.web.server.RequestLog 192.168.1.128 - florent
[12/Jan/2023:15:43:15 +0000] "PUT
/nifi-api/processors/ccdd3d4b-ad30-15d0-df43-453a1016b592/run-status HTTP/1.1"
200 2315
"https://nifi-test.sanbox.net:9447/nifi/?processGroupId=08be022a-aa63-3a5e-8a22-5f0041cc89de&componentIds=ccdd3d4b-ad30-15d0-df43-453a1016b592";
"Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like
Gecko) Chrome/91.0.4472.124 Safari/537.36"
2023-01-12 15:43:15,070 DEBUG [Timer-Driven Process Thread-10]
c.h.s.t.tcp.direct.DirectTcpPacketReader Starting PacketReader on thread:
Packet Reader for 10.10.2.19
2023-01-12 15:43:15,074 DEBUG [Timer-Driven Process Thread-10]
c.h.s.connection.SMBProtocolNegotiator Negotiating dialects [SMB_2_0_2,
SMB_2_1, SMB_3_0, SMB_3_0_2, SMB_3_1_1]
2023-01-12 15:43:15,078 DEBUG [Timer-Driven Process Thread-10]
c.hierynomus.smbj.connection.Connection Granted 1 (out of 1) credits to
SMB2_NEGOTIATE with message id << 0 >>
2023-01-12 15:43:15,081 TRACE [Timer-Driven Process Thread-10]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
SMB2_NEGOTIATE with message id << 0 >> >>
2023-01-12 15:43:15,081 DEBUG [Timer-Driven Process Thread-10]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet SMB2_NEGOTIATE with
message id << 0 >>
2023-01-12 15:43:15,084 TRACE [Timer-Driven Process Thread-10]
c.h.s.t.tcp.direct.DirectTcpTransport Packet SMB2_NEGOTIATE with message id <<
0 >> sent, lock released.
2023-01-12 15:43:15,085 DEBUG [Packet Reader for 10.10.2.19]
c.h.s.t.tcp.direct.DirectTcpPacketReader Received packet SMB2_NEGOTIATE with
message id << 0 >>
2023-01-12 15:43:15,086 DEBUG [Packet Reader for 10.10.2.19]
c.h.s.c.p.SMB2CreditGrantingPacketHandler Server granted us 1 credits for
SMB2_NEGOTIATE with message id << 0 >>, now available: 1 credits
2023-01-12 15:43:15,086 TRACE [Packet Reader for 10.10.2.19]
c.h.s.c.p.SMB2AsyncResponsePacketHandler Send/Recv of packet SMB2_NEGOTIATE
with message id << 0 >> took << 7 ms >>
2023-01-12 15:43:15,120 DEBUG [Timer-Driven Process Thread-10]
c.h.s.connection.SMBProtocolNegotiator Negotiated the following connection
settings: ConnectionContext{
serverGuid=d264fe60-8f3c-4f60-b2c1-e0915c1e1958,
serverName='10.10.2.19',
negotiatedProtocol=NegotiatedProtocol{dialect=SMB_3_1_1,
maxTransactSize=65536, maxReadSize=1048576, maxWriteSize=1048576},
clientGuid=df00ea17-d672-49c0-b427-aed63b93b21a,
clientCapabilities=[SMB2_GLOBAL_CAP_LARGE_MTU],
serverCapabilities=[SMB2_GLOBAL_CAP_DFS, SMB2_GLOBAL_CAP_LEASING,
SMB2_GLOBAL_CAP_LARGE_MTU, SMB2_GLOBAL_CAP_MULTI_CHANNEL,
SMB2_GLOBAL_CAP_PERSISTENT_HANDLES],
clientSecurityMode=1,
serverSecurityMode=1,
server='com.hierynomus.smbj.server.Server@20d8d502'
}
2023-01-12 15:43:15,121 INFO [Timer-Driven Process Thread-10]
c.h.smbj.connection.PacketEncryptor Initialized PacketEncryptor with Cipher <<
AES_128_GCM >>
2023-01-12 15:43:15,123 INFO [Timer-Driven Process Thread-10]
c.hierynomus.smbj.connection.Connection Successfully connected to: 10.10.2.19
2023-01-12 15:43:15,139 DEBUG [Timer-Driven Process Thread-10]
c.hierynomus.smbj.auth.NtlmAuthenticator Initialized Authentication of florent
using NTLM
2023-01-12 15:43:15,146 DEBUG [Timer-Driven Process Thread-10]
c.hierynomus.smbj.connection.Connection Granted 1 (out of 1) credits to
SMB2_SESSION_SETUP with message id << 1 >>
2023-01-12 15:43:15,146 TRACE [Timer-Driven Process Thread-10]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
SMB2_SESSION_SETUP with message id << 1 >> >>
2023-01-12 15:43:15,146 DEBUG [Timer-Driven Process Thread-10]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet SMB2_SESSION_SETUP with
message id << 1 >>
2023-01-12 15:43:15,146 TRACE [Timer-Driven Process Thread-10]
c.h.s.t.tcp.direct.DirectTcpTransport Packet SMB2_SESSION_SETUP with message id
<< 1 >> sent, lock released.
2023-01-12 15:43:15,148 DEBUG [Packet Reader for 10.10.2.19]
c.h.s.t.tcp.direct.DirectTcpPacketReader Received packet SMB2_SESSION_SETUP
with message id << 1 >>
2023-01-12 15:43:15,148 DEBUG [Packet Reader for 10.10.2.19]
c.h.s.c.p.SMB2CreditGrantingPacketHandler Server granted us 128 credits for
SMB2_SESSION_SETUP with message id << 1 >>, now available: 128 credits
2023-01-12 15:43:15,148 TRACE [Packet Reader for 10.10.2.19]
c.h.s.c.p.SMB2AsyncResponsePacketHandler Send/Recv of packet SMB2_SESSION_SETUP
with message id << 1 >> took << 2 ms >>
2023-01-12 15:43:15,153 DEBUG [Timer-Driven Process Thread-10]
c.h.smbj.connection.SMBSessionBuilder More processing required for
authentication of florent using
com.hierynomus.smbj.auth.NtlmAuthenticator@aa94f7d
2023-01-12 15:43:15,154 DEBUG [Timer-Driven Process Thread-10]
c.hierynomus.smbj.auth.NtlmAuthenticator Received token: a1 82 01 05 30 82 01
01 a0 82 00 03 0a 01 01 a1 82 00 0c 06 0a 2b 06 01 04 01 82 37 02 02 0a a2 82
00 e6 04 82 00 e2 4e 54 4c 4d 53 53 50 00 02 00 00 00 1c 00 1c 00 30 00 00 00
15 82 89 60 9e 97 ae 29 76 e5 11 dd 00 00 00 00 00 00 00 00 96 00 96 00 4c 00
00 00 44 00 41 00 53 00 53 00 41 00 55 00 4c 00 54 00 2d 00 41 00 56 00 49 00
4f 00 4e 00 01 00 10 00 44 00 41 00 46 00 30 00 39 00 38 00 50 00 31 00 02 00
1c 00 44 00 41 00 53 00 53 00 41 00 55 00 4c 00 54 00 2d 00 41 00 56 00 49 00
4f 00 4e 00 03 00 34 00 44 00 41 00 46 00 30 00 39 00 38 00 50 00 31 00 2e 00
44 00 41 00 53 00 53 00 41 00 55 00 4c 00 54 00 2d 00 41 00 56 00 49 00 4f 00
4e 00 2e 00 46 00 52 00 04 00 22 00 44 00 41 00 53 00 53 00 41 00 55 00 4c 00
54 00 2d 00 41 00 56 00 49 00 4f 00 4e 00 2e 00 46 00 52 00 00 00 00 00
2023-01-12 15:43:15,160 DEBUG [Timer-Driven Process Thread-10]
c.hierynomus.smbj.auth.NtlmAuthenticator Received NTLM challenge from:
SANDBOX-DOMAIN
2023-01-12 15:43:15,173 DEBUG [Timer-Driven Process Thread-10]
c.hierynomus.smbj.connection.Connection Granted 1 (out of 128) credits to
SMB2_SESSION_SETUP with message id << 2 >>
2023-01-12 15:43:15,173 TRACE [Timer-Driven Process Thread-10]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
SMB2_SESSION_SETUP with message id << 2 >> >>
2023-01-12 15:43:15,173 DEBUG [Timer-Driven Process Thread-10]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet SMB2_SESSION_SETUP with
message id << 2 >>
2023-01-12 15:43:15,173 TRACE [Timer-Driven Process Thread-10]
c.h.s.t.tcp.direct.DirectTcpTransport Packet SMB2_SESSION_SETUP with message id
<< 2 >> sent, lock released.
2023-01-12 15:43:15,192 DEBUG [Packet Reader for 10.10.2.19]
c.h.s.t.tcp.direct.DirectTcpPacketReader Received packet SMB2_SESSION_SETUP
with message id << 2 >>
2023-01-12 15:43:15,192 DEBUG [Packet Reader for 10.10.2.19]
c.h.s.c.p.SMB2CreditGrantingPacketHandler Server granted us 1 credits for
SMB2_SESSION_SETUP with message id << 2 >>, now available: 128 credits
2023-01-12 15:43:15,192 TRACE [Packet Reader for 10.10.2.19]
c.h.s.c.p.SMB2AsyncResponsePacketHandler Send/Recv of packet SMB2_SESSION_SETUP
with message id << 2 >> took << 19 ms >>
2023-01-12 15:43:15,199 INFO [Timer-Driven Process Thread-10]
c.h.smbj.connection.SMBSessionBuilder Successfully authenticated florent on
10.10.2.19, session is -6929069501598538969
2023-01-12 15:43:15,199 INFO [Timer-Driven Process Thread-10]
com.hierynomus.smbj.session.Session Connecting to \\10.10.2.19\HOMES on session
-6929069501598538969
2023-01-12 15:43:15,199 DEBUG [Timer-Driven Process Thread-10]
c.hierynomus.smbj.connection.Connection Granted 1 (out of 128) credits to
Encrypted[SMB2_TREE_CONNECT with message id << 3 >>]
2023-01-12 15:43:15,199 TRACE [Timer-Driven Process Thread-10]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
Encrypted[SMB2_TREE_CONNECT with message id << 3 >>] >>
2023-01-12 15:43:15,199 DEBUG [Timer-Driven Process Thread-10]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet
Encrypted[SMB2_TREE_CONNECT with message id << 3 >>]
2023-01-12 15:43:15,207 TRACE [Timer-Driven Process Thread-10]
c.h.s.t.tcp.direct.DirectTcpTransport Packet Encrypted[SMB2_TREE_CONNECT with
message id << 3 >>] sent, lock released.
2023-01-12 15:43:15,209 DEBUG [Packet Reader for 10.10.2.19]
c.h.s.t.tcp.direct.DirectTcpPacketReader Received packet Encrypted for session
id << -6929069501598538969 >>
2023-01-12 15:43:15,209 DEBUG [Packet Reader for 10.10.2.19]
c.h.s.c.p.SMB3DecryptingPacketHandler Decrypting packet Encrypted for session
id << -6929069501598538969 >>
2023-01-12 15:43:15,210 DEBUG [Packet Reader for 10.10.2.19]
c.h.s.c.p.SMB3DecryptingPacketHandler Decrypted packet Encrypted for session id
<< -6929069501598538969 >> is packet SMB2_TREE_CONNECT with message id << 3 >>.
2023-01-12 15:43:15,210 DEBUG [Packet Reader for 10.10.2.19]
c.h.s.c.p.SMB2SignatureVerificationPacketHandler Passthrough Signature
Verification as packet is decrypted
2023-01-12 15:43:15,210 DEBUG [Packet Reader for 10.10.2.19]
c.h.s.c.p.SMB2CreditGrantingPacketHandler Server granted us 1 credits for
SMB2_TREE_CONNECT with message id << 3 >>, now available: 128 credits
2023-01-12 15:43:15,210 TRACE [Packet Reader for 10.10.2.19]
c.h.s.c.p.SMB2AsyncResponsePacketHandler Send/Recv of packet SMB2_TREE_CONNECT
with message id << 3 >> took << 11 ms >>
2023-01-12 15:43:15,224 DEBUG [Timer-Driven Process Thread-10]
c.hierynomus.smbj.connection.Connection Granted 1 (out of 128) credits to
Encrypted[SMB2_CREATE with message id << 4 >>]
2023-01-12 15:43:15,224 TRACE [Timer-Driven Process Thread-10]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
Encrypted[SMB2_CREATE with message id << 4 >>] >>
2023-01-12 15:43:15,224 DEBUG [Timer-Driven Process Thread-10]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet Encrypted[SMB2_CREATE with
message id << 4 >>]
2023-01-12 15:43:15,225 TRACE [Timer-Driven Process Thread-10]
c.h.s.t.tcp.direct.DirectTcpTransport Packet Encrypted[SMB2_CREATE with message
id << 4 >>] sent, lock released.
2023-01-12 15:43:15,225 DEBUG [Packet Reader for 10.10.2.19]
c.h.s.t.tcp.direct.DirectTcpPacketReader Received packet Encrypted for session
id << -6929069501598538969 >>
2023-01-12 15:43:15,225 DEBUG [Packet Reader for 10.10.2.19]
c.h.s.c.p.SMB3DecryptingPacketHandler Decrypting packet Encrypted for session
id << -6929069501598538969 >>
2023-01-12 15:43:15,225 DEBUG [Packet Reader for 10.10.2.19]
c.h.s.c.p.SMB3DecryptingPacketHandler Decrypted packet Encrypted for session id
<< -6929069501598538969 >> is packet SMB2_CREATE with message id << 4 >>.
2023-01-12 15:43:15,225 DEBUG [Packet Reader for 10.10.2.19]
c.h.s.c.p.SMB2SignatureVerificationPacketHandler Passthrough Signature
Verification as packet is decrypted
2023-01-12 15:43:15,225 DEBUG [Packet Reader for 10.10.2.19]
c.h.s.c.p.SMB2CreditGrantingPacketHandler Server granted us 1 credits for
SMB2_CREATE with message id << 4 >>, now available: 128 credits
2023-01-12 15:43:15,225 TRACE [Packet Reader for 10.10.2.19]
c.h.s.c.p.SMB2AsyncResponsePacketHandler Send/Recv of packet SMB2_CREATE with
message id << 4 >> took << 1 ms >>
2023-01-12 15:43:15,227 DEBUG [Timer-Driven Process Thread-10]
c.hierynomus.smbj.connection.Connection Granted 1 (out of 128) credits to
Encrypted[SMB2_TREE_DISCONNECT with message id << 5 >>]
2023-01-12 15:43:15,227 TRACE [Timer-Driven Process Thread-10]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
Encrypted[SMB2_TREE_DISCONNECT with message id << 5 >>] >>
2023-01-12 15:43:15,227 DEBUG [Timer-Driven Process Thread-10]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet
Encrypted[SMB2_TREE_DISCONNECT with message id << 5 >>]
2023-01-12 15:43:15,227 TRACE [Timer-Driven Process Thread-10]
c.h.s.t.tcp.direct.DirectTcpTransport Packet Encrypted[SMB2_TREE_DISCONNECT
with message id << 5 >>] sent, lock released.
2023-01-12 15:43:15,229 DEBUG [Packet Reader for 10.10.2.19]
c.h.s.t.tcp.direct.DirectTcpPacketReader Received packet Encrypted for session
id << -6929069501598538969 >>
2023-01-12 15:43:15,229 DEBUG [Packet Reader for 10.10.2.19]
c.h.s.c.p.SMB3DecryptingPacketHandler Decrypting packet Encrypted for session
id << -6929069501598538969 >>
2023-01-12 15:43:15,229 DEBUG [Packet Reader for 10.10.2.19]
c.h.s.c.p.SMB3DecryptingPacketHandler Decrypted packet Encrypted for session id
<< -6929069501598538969 >> is packet SMB2_TREE_DISCONNECT with message id << 5
>>.
2023-01-12 15:43:15,229 DEBUG [Packet Reader for 10.10.2.19]
c.h.s.c.p.SMB2SignatureVerificationPacketHandler Passthrough Signature
Verification as packet is decrypted
2023-01-12 15:43:15,229 DEBUG [Packet Reader for 10.10.2.19]
c.h.s.c.p.SMB2CreditGrantingPacketHandler Server granted us 1 credits for
SMB2_TREE_DISCONNECT with message id << 5 >>, now available: 128 credits
2023-01-12 15:43:15,229 TRACE [Packet Reader for 10.10.2.19]
c.h.s.c.p.SMB2AsyncResponsePacketHandler Send/Recv of packet
SMB2_TREE_DISCONNECT with message id << 5 >> took << 2 ms >>
2023-01-12 15:43:15,231 DEBUG [Timer-Driven Process Thread-10]
com.hierynomus.smbj.session.Session Notified of TreeDisconnected <<1>>
2023-01-12 15:43:15,231 INFO [Timer-Driven Process Thread-10]
com.hierynomus.smbj.session.Session Logging off session -6929069501598538969
from host 10.10.2.19
2023-01-12 15:43:15,231 DEBUG [Timer-Driven Process Thread-10]
c.hierynomus.smbj.connection.Connection Granted 1 (out of 128) credits to
Encrypted[SMB2_LOGOFF with message id << 6 >>]
2023-01-12 15:43:15,231 TRACE [Timer-Driven Process Thread-10]
c.h.s.t.tcp.direct.DirectTcpTransport Acquiring write lock to send packet <<
Encrypted[SMB2_LOGOFF with message id << 6 >>] >>
2023-01-12 15:43:15,231 DEBUG [Timer-Driven Process Thread-10]
c.h.s.t.tcp.direct.DirectTcpTransport Writing packet Encrypted[SMB2_LOGOFF with
message id << 6 >>]
2023-01-12 15:43:15,231 TRACE [Timer-Driven Process Thread-10]
c.h.s.t.tcp.direct.DirectTcpTransport Packet Encrypted[SMB2_LOGOFF with message
id << 6 >>] sent, lock released.
2023-01-12 15:43:15,232 DEBUG [Packet Reader for 10.10.2.19]
c.h.s.t.tcp.direct.DirectTcpPacketReader Received packet Encrypted for session
id << -6929069501598538969 >>
2023-01-12 15:43:15,232 DEBUG [Packet Reader for 10.10.2.19]
c.h.s.c.p.SMB3DecryptingPacketHandler Decrypting packet Encrypted for session
id << -6929069501598538969 >>
2023-01-12 15:43:15,232 DEBUG [Packet Reader for 10.10.2.19]
c.h.s.c.p.SMB3DecryptingPacketHandler Decrypted packet Encrypted for session id
<< -6929069501598538969 >> is packet SMB2_LOGOFF with message id << 6 >>.
2023-01-12 15:43:15,232 DEBUG [Packet Reader for 10.10.2.19]
c.h.s.c.p.SMB2SignatureVerificationPacketHandler Passthrough Signature
Verification as packet is decrypted
2023-01-12 15:43:15,232 DEBUG [Packet Reader for 10.10.2.19]
c.h.s.c.p.SMB2CreditGrantingPacketHandler Server granted us 1 credits for
SMB2_LOGOFF with message id << 6 >>, now available: 128 credits
2023-01-12 15:43:15,232 TRACE [Packet Reader for 10.10.2.19]
c.h.s.c.p.SMB2AsyncResponsePacketHandler Send/Recv of packet SMB2_LOGOFF with
message id << 6 >> took << 1 ms >>
2023-01-12 15:43:15,232 DEBUG [Timer-Driven Process Thread-10]
c.hierynomus.smbj.connection.Connection Session << -6929069501598538969 >>
logged off
2023-01-12 15:43:15,232 DEBUG [Timer-Driven Process Thread-10]
c.h.s.t.tcp.direct.DirectTcpPacketReader Stopping PacketReader...
2023-01-12 15:43:15,232 INFO [Timer-Driven Process Thread-10]
c.hierynomus.smbj.connection.Connection Closed connection to 10.10.2.19
2023-01-12 15:43:15,232 DEBUG [Timer-Driven Process Thread-10]
com.hierynomus.smbj.SMBClient Connection to << 10.10.2.19:445 >> closed
2023-01-12 15:43:15,233 ERROR [Timer-Driven Process Thread-10]
o.apache.nifi.processors.smb.GetSmbFile
GetSmbFile[id=ccdd3d4b-ad30-15d0-df43-453a1016b592] Could not establish smb
connection because of error com.hierynomus.mssmb2.SMBApiException:
STATUS_ACCESS_DENIED (0xc0000022): Create failed for \\10.10.2.19\HOMES\florent
com.hierynomus.mssmb2.SMBApiException: STATUS_ACCESS_DENIED (0xc0000022):
Create failed for \\10.10.2.19\HOMES\florent
at com.hierynomus.smbj.share.Share.receive(Share.java:380)
at com.hierynomus.smbj.share.Share.sendReceive(Share.java:359)
at com.hierynomus.smbj.share.Share.createFile(Share.java:156)
at
com.hierynomus.smbj.share.DiskShare.createFileAndResolve(DiskShare.java:75)
at com.hierynomus.smbj.share.DiskShare.access$100(DiskShare.java:55)
at com.hierynomus.smbj.share.DiskShare$2.apply(DiskShare.java:109)
at com.hierynomus.smbj.share.DiskShare$2.apply(DiskShare.java:105)
at com.hierynomus.smbj.paths.PathResolver$1.resolve(PathResolver.java:32)
at
com.hierynomus.smbj.paths.SymlinkPathResolver.resolve(SymlinkPathResolver.java:62)
at
com.hierynomus.smbj.share.DiskShare.resolveAndCreateFile(DiskShare.java:105)
at com.hierynomus.smbj.share.DiskShare.open(DiskShare.java:65)
at com.hierynomus.smbj.share.DiskShare.exists(DiskShare.java:214)
at com.hierynomus.smbj.share.DiskShare.folderExists(DiskShare.java:210)
at
org.apache.nifi.processors.smb.GetSmbFile.performListing(GetSmbFile.java:334)
at org.apache.nifi.processors.smb.GetSmbFile.onTrigger(GetSmbFile.java:404)
at
org.apache.nifi.processor.AbstractProcessor.onTrigger(AbstractProcessor.java:27)
at
org.apache.nifi.controller.StandardProcessorNode.onTrigger(StandardProcessorNode.java:1356)
at
org.apache.nifi.controller.tasks.ConnectableTask.invoke(ConnectableTask.java:246)
at
org.apache.nifi.controller.scheduling.AbstractTimeBasedSchedulingAgent.lambda$doScheduleOnce$0(AbstractTimeBasedSchedulingAgent.java:59)
at org.apache.nifi.engine.FlowEngine$2.run(FlowEngine.java:110)
at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Unknown
Source)
at java.base/java.util.concurrent.FutureTask.run(Unknown Source)
at
java.base/java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(Unknown
Source)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown
Source)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown
Source)
at java.base/java.lang.Thread.run(Unknown Source)
Suppressed: com.hierynomus.mssmb2.SMBApiException: STATUS_ACCESS_DENIED
(0xc0000022): Error closing connection to \\10.10.2.19\HOMES
at com.hierynomus.smbj.share.TreeConnect.close(TreeConnect.java:72)
at com.hierynomus.smbj.share.Share.close(Share.java:116)
at
org.apache.nifi.processors.smb.GetSmbFile.onTrigger(GetSmbFile.java:545)
... 11 common frames omitted
2023-01-12 15:43:15,236 INFO [Packet Reader for 10.10.2.19]
c.h.s.t.tcp.direct.DirectTcpPacketReader Thread[Packet Reader for
10.10.2.19,5,main] stopped.
2023-01-12 15:43:15,240 INFO [Timer-Driven Process Thread-10]
o.a.n.c.s.StandardProcessScheduler Stopping
GetSmbFile[id=ccdd3d4b-ad30-15d0-df43-453a1016b592]
2023-01-12 15:43:15,240 INFO [Timer-Driven Process Thread-10]
o.a.n.controller.StandardProcessorNode Stopping processor:
GetSmbFile[id=ccdd3d4b-ad30-15d0-df43-453a1016b592]
2023-01-12 15:43:15,240 INFO [Timer-Driven Process Thread-10]
o.a.n.c.s.TimerDrivenSchedulingAgent Stopped scheduling
GetSmbFile[id=ccdd3d4b-ad30-15d0-df43-453a1016b592] to run
2023-01-12 15:43:15,240 INFO [Timer-Driven Process Thread-10]
o.a.n.controller.StandardProcessorNode
GetSmbFile[id=ccdd3d4b-ad30-15d0-df43-453a1016b592] has completely stopped.
Completing any associated Futures.
2023-01-12 15:43:15,473 INFO [Flow Service Tasks Thread-1]
o.a.nifi.controller.StandardFlowService Saved flow controller
org.apache.nifi.controller.FlowController@49d2f500 // Another save pending =
false
2023-01-12 15:43:25,676 INFO [pool-7-thread-1]
o.a.n.c.r.WriteAheadFlowFileRepository Initiating checkpoint of FlowFile
Repository
2023-01-12 15:43:25,676 INFO [pool-7-thread-1]
o.a.n.c.r.WriteAheadFlowFileRepository Successfully checkpointed FlowFile
Repository with 2 records in 0 milliseconds
2023-01-12 15:43:26,112 INFO [NiFi Web Server-19]
org.apache.nifi.web.server.RequestLog 192.168.1.128 - florent
[12/Jan/2023:15:43:26 +0000] "GET
/nifi-api/flow/process-groups/08be022a-aa63-3a5e-8a22-5f0041cc89de?uiOnly=true
HTTP/1.1" 200 2487
"https://nifi-test.sanbox.net:9447/nifi/?processGroupId=08be022a-aa63-3a5e-8a22-5f0041cc89de&componentIds=ccdd3d4b-ad30-15d0-df43-453a1016b592";
"Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like
Gecko) Chrome/91.0.4472.124 Safari/537.36"
2023-01-12 15:43:26,134 INFO [NiFi Web Server-25]
org.apache.nifi.web.server.RequestLog 192.168.1.128 - florent
[12/Jan/2023:15:43:26 +0000] "GET /nifi-api/flow/status HTTP/1.1" 200 215
"https://nifi-test.sanbox.net:9447/nifi/?processGroupId=08be022a-aa63-3a5e-8a22-5f0041cc89de&componentIds=ccdd3d4b-ad30-15d0-df43-453a1016b592";
"Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like
Gecko) Chrome/91.0.4472.124 Safari/537.36"
2023-01-12 15:43:26,151 INFO [NiFi Web Server-20]
org.apache.nifi.web.server.RequestLog 192.168.1.128 - florent
[12/Jan/2023:15:43:26 +0000] "GET /nifi-api/flow/controller/bulletins HTTP/1.1"
200 109
"https://nifi-test.sanbox.net:9447/nifi/?processGroupId=08be022a-aa63-3a5e-8a22-5f0041cc89de&componentIds=ccdd3d4b-ad30-15d0-df43-453a1016b592";
"Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like
Gecko) Chrome/91.0.4472.124 Safari/537.36"
2023-01-12 15:43:26,167 INFO [NiFi Web Server-20]
org.apache.nifi.web.server.RequestLog 192.168.1.128 - florent
[12/Jan/2023:15:43:26 +0000] "GET /nifi-api/flow/cluster/summary HTTP/1.1" 200
92
"https://nifi-test.sanbox.net:9447/nifi/?processGroupId=08be022a-aa63-3a5e-8a22-5f0041cc89de&componentIds=ccdd3d4b-ad30-15d0-df43-453a1016b592";
"Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like
Gecko) Chrome/91.0.4472.124 Safari/537.36"
2023-01-12 15:43:26,174 INFO [NiFi Web Server-19]
org.apache.nifi.web.server.RequestLog 192.168.1.128 - florent
[12/Jan/2023:15:43:26 +0000] "GET /nifi-api/flow/current-user HTTP/1.1" 200 383
"https://nifi-test.sanbox.net:9447/nifi/?processGroupId=08be022a-aa63-3a5e-8a22-5f0041cc89de&componentIds=ccdd3d4b-ad30-15d0-df43-453a1016b592";
"Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like
Gecko) Chrome/91.0.4472.124 Safari/537.36"
2023-01-12 15:43:40,849 INFO [Cleanup Archive for default]
o.a.n.c.repository.FileSystemRepository Successfully deleted 0 files (0 bytes)
from archive
2023-01-12 15:43:40,849 INFO [Cleanup Archive for default]
o.a.n.c.repository.FileSystemRepository Archive cleanup completed for container
default; will now allow writing to this container. Bytes used = 584.46 MB,
bytes free = 4.23 GB, capacity = 4.8 GB
2023-01-12 15:43:40,898 INFO [Write-Ahead Local State Provider Maintenance]
org.wali.MinimalLockingWriteAheadLog
org.wali.MinimalLockingWriteAheadLog@b1d7b09 checkpointed with 4296 Records and
0 Swap Files in 20 milliseconds (Stop-the-world time = 2 milliseconds, Clear
Edit Logs time = 1 millis), max Transaction ID 2333779
2023-01-12 15:43:45,676 INFO [pool-7-thread-1]
o.a.n.c.r.WriteAheadFlowFileRepository Initiating checkpoint of FlowFile
Repository
2023-01-12 15:43:45,677 INFO [pool-7-thread-1]
o.a.n.c.r.WriteAheadFlowFileRepository Successfully checkpointed FlowFile
Repository with 2 records in 0 milliseconds{code}
> GetSmbFile issue after upgrading to Nifi 1.18.0
> -----------------------------------------------
>
> Key: NIFI-10846
> URL: https://issues.apache.org/jira/browse/NIFI-10846
> Project: Apache NiFi
> Issue Type: Bug
> Affects Versions: 1.18.0
> Environment: Nifi Docker on RHEL7.9
> Samba Server : SVM on a metrocluster Netapp, model AFFA400, Ontap version 9.6
> Reporter: Florent
> Assignee: Peter Turcsanyi
> Priority: Blocker
> Attachments: getsmb_error.png, nifi-app-debug.log
>
>
> After upgrading Nifi from 1.17.0 to 1.18.0, we saw some issue regarding
> Processors o.apache.nifi.processors.smb.*
>
> a Simple GetSmbFile works perfectly in 1.17.0 and after upgrading to 1.18.0
> we saw this error
> {code:java}
> 022-11-21 10:16:29,272 ERROR [Timer-Driven Process Thread-5]
> o.apache.nifi.processors.smb.GetSmbFile
> GetSmbFile[id=8b56acf9-0184-1000-ac23-874fb1140496] Could not establish smb
> connection because of error com.hierynomus.mssmb2.SMBApiException:
> STATUS_ACCESS_DENIED (0xc0000022): Create failed for
> \\MYSERVER\MySHARE\Directory
> at com.hierynomus.smbj.share.Share.receive(Share.java:380)
> at com.hierynomus.smbj.share.Share.sendReceive(Share.java:359)
> at com.hierynomus.smbj.share.Share.createFile(Share.java:156)
> at
> com.hierynomus.smbj.share.DiskShare.createFileAndResolve(DiskShare.java:75)
> at com.hierynomus.smbj.share.DiskShare.access$100(DiskShare.java:55)
> at com.hierynomus.smbj.share.DiskShare$2.apply(DiskShare.java:109)
> at com.hierynomus.smbj.share.DiskShare$2.apply(DiskShare.java:105)
> at
> com.hierynomus.smbj.paths.PathResolver$1.resolve(PathResolver.java:32)
> at
> com.hierynomus.smbj.paths.SymlinkPathResolver.resolve(SymlinkPathResolver.java:62)
> at
> com.hierynomus.smbj.share.DiskShare.resolveAndCreateFile(DiskShare.java:105)
> at com.hierynomus.smbj.share.DiskShare.open(DiskShare.java:65)
> at com.hierynomus.smbj.share.DiskShare.exists(DiskShare.java:214)
> at
> com.hierynomus.smbj.share.DiskShare.folderExists(DiskShare.java:210)
> at
> org.apache.nifi.processors.smb.GetSmbFile.performListing(GetSmbFile.java:334)
> at
> org.apache.nifi.processors.smb.GetSmbFile.onTrigger(GetSmbFile.java:404)
> at
> org.apache.nifi.processor.AbstractProcessor.onTrigger(AbstractProcessor.java:27)
> at
> org.apache.nifi.controller.StandardProcessorNode.onTrigger(StandardProcessorNode.java:1354)
> at
> org.apache.nifi.controller.tasks.ConnectableTask.invoke(ConnectableTask.java:246)
> at
> org.apache.nifi.controller.scheduling.AbstractTimeBasedSchedulingAgent.lambda$doScheduleOnce$0(AbstractTimeBasedSchedulingAgent.java:59)
> at org.apache.nifi.engine.FlowEngine$2.run(FlowEngine.java:110)
> at
> java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
> at java.util.concurrent.FutureTask.run(FutureTask.java:266)
> at
> java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
> at
> java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
> at
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
> at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
> at java.lang.Thread.run(Thread.java:750)
> Suppressed: com.hierynomus.mssmb2.SMBApiException:
> STATUS_ACCESS_DENIED (0xc0000022): Error closing connection to
> \\MYSERVER\MySHARE
> at
> com.hierynomus.smbj.share.TreeConnect.close(TreeConnect.java:72)
> at com.hierynomus.smbj.share.Share.close(Share.java:116)
> at org.apache.nifi.processors.s {code}
> {{{}We have the same error "{}}}{{{}STATUS_ACCESS_DENIED
> (0xc0000022){}}}{{{}" with other processor like ListSmb{}}}
--
This message was sent by Atlassian Jira
(v8.20.10#820010)
