one test  more with scan-type=9

I  see http flows (on usb ?)    and at a moment an error   hp-scan: http.c 322: invalid http_status=503


Apr 22 22:39:24 jarno-MS-7817 hp-scan: hp-scan[17987]: warning: No destinations specified. Adding 'file' destination by default.
Apr 22 22:39:41 jarno-MS-7817 hp-scan: scan/sane/escl.c 418: escl_open() session=(nil)
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 427: Found interface conf=0, iface=0, altset=0, index=1
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 389: Active kernel driver on interface=0 ret=0
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 535: claimed 7/1/2 interface
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 781: read actual device_id successfully fd=1 len=239
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 561: released 7/1/2 interface
Apr 22 22:39:41 jarno-MS-7817 hp-scan: common/utils.c 245: unable to load library libm.so: /usr/lib/x86_64-linux-gnu/libm.so: invalid ELF header
Apr 22 22:39:41 jarno-MS-7817 hp-scan: scan/sane/escl.c 59: Calling bb_open
Apr 22 22:39:41 jarno-MS-7817 hp-scan: scan/sane/escl.c 80: Calling bb_load EXIT
Apr 22 22:39:41 jarno-MS-7817 hp-scan: scan/sane/escl.c 438: escl_open() calling bb_escl.so PASSED
Apr 22 22:39:41 jarno-MS-7817 hp-scan: scan/sane/escl.c 283: init_options....
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 1067: bb_open() escl entry.
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 939: bb_get_scanner_elements.
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 249: http_open() dd=1 channel=HP-ESCL-SCAN handle=0x5612cd363060
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 961: new HP-ESCL-SCAN channel=26 clientCnt=1 channelCnt=1
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 1567: invalid HP-ESCL-SCAN channel=26
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 976: removed HP-ESCL-SCAN channel=26 clientCnt=0 channelCnt=0
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 263: unable to open HP-ESCL-SCAN channel
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 249: http_open() dd=1 channel=HP-IPP handle=0x5612cd363060
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 961: new HP-IPP channel=45 clientCnt=1 channelCnt=1
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 427: Found interface conf=0, iface=1, altset=1, index=3
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 389: Active kernel driver on interface=1 ret=0
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 535: claimed 7/1/4 interface
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 552: http_write() handle=0x5612cd663220 data=0x7fe234034988 size=56 sectime=3
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 815: bb_read_http_payload entry.
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 300: http_read_header() handle=0x5612cd663220 data=0x7fff885165d0 size=32768 sectime=3
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 166: read_channel len=1024
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 189: -read_stream() bytes_read=1 s.index=1 s.cnt=1023 stat=0
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 239: read_line len=17 index=17 cnt=1007
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 239: read_line len=31 index=48 cnt=976
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=31 total=48
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 239: read_line len=22 index=70 cnt=954
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=22 total=70
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 239: read_line len=52 index=122 cnt=902
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=52 total=122
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 239: read_line len=30 index=152 cnt=872
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=30 total=152
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 239: read_line len=24 index=176 cnt=848
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=24 total=176
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 239: read_line len=2 index=178 cnt=846
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=2 total=178
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 345: -http_read_header() handle=0x5612cd663220 data=0x7fff885165d0 bytes_read=178 size=32768 status=0
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 853: payload_length= (3338)
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 90: clear_stream entry...
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 97: Clearing (846) bytes from the stream
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 105: clear_stream returning with (stat = 0, bytes_read = 846)...
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 435: http_read2 entry.
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 439: http_read2 successful. (1024 bytes read). 
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 919: bytes_remaining= 1468 total=[1870] ret = [0].#012 
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 435: http_read2 entry.
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 439: http_read2 successful. (1024 bytes read). 
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 919: bytes_remaining= 444 total=[2894] ret = [0].#012 
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 435: http_read2 entry.
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 439: http_read2 successful. (444 bytes read). 
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 919: bytes_remaining= 0 total=[3338] ret = [0].#012 
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 928: bb_read_http_payload completed. total=[3338] stat=[0] 
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 267: bb_parse_scan_elements entry.
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 278: Version:2.63
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 337: Platen FormatSupported ColorMode:RGB24
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 337: Platen FormatSupported ColorMode:Grayscale8
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 360: Platen Resolution:200
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 360: Platen Resolution:300
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 360: Platen Resolution:600
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 393: Platen Optical Resolution Max X:600
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 398: Platen Optical Resolution Max Y:600
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 721: bb_parse_scan_elements successful
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 284: http_close() handle=0x5612cd663220
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 561: released 7/1/4 interface
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 976: removed HP-IPP channel=45 clientCnt=0 channelCnt=0
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 977: bb_get_scanner_elements returning with (stat=0).
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 1080: UpdateResolutionListForRange ESCL
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 1144: Platen minWidth=499384 minHeight=499384 Range[14149223, 14149223, 19464892, 19464892] 
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 1153: ADF Simplex minWidth=0 minHeight=0 Range[0, 0, 0, 0] 
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 1163: ADF Duplex minWidth=0 minHeight=0 Range[0, 0, 0, 0] 
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 1173: Camera minWidth=0 minHeight=0 Range[0, 0, 0, 0] 
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 1211: bb_open() returning stat=0.
Apr 22 22:39:41 jarno-MS-7817 hp-scan: scan/sane/escl.c 219: set_scan_mode_side_effects....
Apr 22 22:39:41 jarno-MS-7817 hp-scan: scan/sane/escl.c 241: set_input_source_side_effects....
Apr 22 22:39:41 jarno-MS-7817 hp-scan: scan/sane/escl.c 798: control_option failed: option=geometry-group action=set
Apr 22 22:39:41 jarno-MS-7817 hp-scan: scan/sane/escl.c 241: set_input_source_side_effects....
Apr 22 22:39:41 jarno-MS-7817 hp-scan: scan/sane/escl.c 604: Resolution (75) is not supported in input source (1).
Apr 22 22:39:41 jarno-MS-7817 hp-scan: scan/sane/escl.c 798: control_option failed: option=geometry-group action=set
Apr 22 22:39:41 jarno-MS-7817 hp-scan: scan/sane/escl.c 798: control_option failed: option=geometry-group action=set
Apr 22 22:39:41 jarno-MS-7817 hp-scan: scan/sane/escl.c 219: set_scan_mode_side_effects....
Apr 22 22:39:41 jarno-MS-7817 hp-scan: scan/sane/escl.c 798: control_option failed: option=geometry-group action=set
Apr 22 22:39:41 jarno-MS-7817 hp-scan: hp-scan[17987]: warning: File destination enabled with no output file specified.
Apr 22 22:39:41 jarno-MS-7817 hp-scan: hp-scan[17987]: warning: Defaulting to '/var/log/hpscan001.png'.
Apr 22 22:39:41 jarno-MS-7817 hp-scan: scan/sane/escl.c 864: escl_start entry. uri=[hp:/usb/HP_LaserJet_MFP_M28-M31?serial=VNC3B92743] InputSource=[1]
Apr 22 22:39:41 jarno-MS-7817 hp-scan: scan/sane/escl.c 241: set_input_source_side_effects....
Apr 22 22:39:41 jarno-MS-7817 hp-scan: scan/sane/escl.c 114: escl_set_extents minWidth=499384 minHeight=499384 Source Range[14149223, 14149223, 19464892, 19464892] Current Range[0, 14149223, 0, 19464892]
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 1493: bb_check_scanner_to_continue entry
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 1287: bb_get_scanner_status entry.
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 249: http_open() dd=1 channel=HP-IPP handle=0x5612cd363060
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 961: new HP-IPP channel=45 clientCnt=1 channelCnt=1
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 427: Found interface conf=0, iface=1, altset=1, index=3
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 389: Active kernel driver on interface=1 ret=0
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 535: claimed 7/1/4 interface
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 1294: bb_get_scanner_status returning
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 552: http_write() handle=0x5612cd668610 data=0x7fe234035260 size=49 sectime=10
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 815: bb_read_http_payload entry.
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 300: http_read_header() handle=0x5612cd668610 data=0x7fff8851d040 size=5120 sectime=10
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 166: read_channel len=1024
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 189: -read_stream() bytes_read=1 s.index=1 s.cnt=1023 stat=0
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 239: read_line len=17 index=17 cnt=1007
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 239: read_line len=31 index=48 cnt=976
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=31 total=48
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 239: read_line len=22 index=70 cnt=954
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=22 total=70
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 239: read_line len=52 index=122 cnt=902
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=52 total=122
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 239: read_line len=30 index=152 cnt=872
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=30 total=152
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 239: read_line len=24 index=176 cnt=848
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=24 total=176
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 239: read_line len=2 index=178 cnt=846
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=2 total=178
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 345: -http_read_header() handle=0x5612cd668610 data=0x7fff8851d040 bytes_read=178 size=5120 status=0
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 853: payload_length= (1545)
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 90: clear_stream entry...
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 97: Clearing (846) bytes from the stream
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 105: clear_stream returning with (stat = 0, bytes_read = 846)...
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 435: http_read2 entry.
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 439: http_read2 successful. (699 bytes read). 
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 919: bytes_remaining= 0 total=[1545] ret = [0].#012 
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 928: bb_read_http_payload completed. total=[1545] stat=[0] 
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 284: http_close() handle=0x5612cd668610
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 561: released 7/1/4 interface
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 976: removed HP-IPP channel=45 clientCnt=0 channelCnt=0
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 1312: bb_get_scanner_status returning (0)
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 1531: bb_check_scanner_to_continue returning with (0).
Apr 22 22:39:41 jarno-MS-7817 hp-scan: scan/sane/escl.c 852: escl_send_event event[0] uri[hp:/usb/HP_LaserJet_MFP_M28-M31?serial=VNC3B92743]
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 1718: bb_start_scan entry. job_id=,  input_src[1]
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 1547: bb_post_scanjob.
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 249: http_open() dd=1 channel=HP-IPP handle=0x5612cd363060
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 961: new HP-IPP channel=45 clientCnt=1 channelCnt=1
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 427: Found interface conf=0, iface=1, altset=1, index=3
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 389: Active kernel driver on interface=1 ret=0
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 535: claimed 7/1/4 interface
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 1558: Requested_width = [2550], max_width = [2549]
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 552: http_write() handle=0x5612cd668610 data=0x7fff8851b3f0 size=90 sectime=5
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 552: http_write() handle=0x5612cd668610 data=0x7fff8851bbf0 size=743 sectime=1
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 815: bb_read_http_payload entry.
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 300: http_read_header() handle=0x5612cd668610 data=0x7fff8851bbf0 size=5120 sectime=5
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 166: read_channel len=208
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 189: -read_stream() bytes_read=1 s.index=1 s.cnt=207 stat=0
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 239: read_line len=22 index=22 cnt=186
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 239: read_line len=19 index=41 cnt=167
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=19 total=41
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 239: read_line len=52 index=93 cnt=115
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=52 total=93
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 239: read_line len=59 index=152 cnt=56
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=59 total=152
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 239: read_line len=30 index=182 cnt=26
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=30 total=182
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 239: read_line len=24 index=206 cnt=2
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=24 total=206
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 239: read_line len=2 index=0 cnt=0
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=2 total=208
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 345: -http_read_header() handle=0x5612cd668610 data=0x7fff8851bbf0 bytes_read=208 size=5120 status=0
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 1368: bb_get_url URL=/eSCL/ScanJobs/wyivwwzz-50ci-2dgz-1013-qct2k1gp
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 1383: bb_get_url ip=
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 1397: bb_get_url job_id=wyivwwzz-50ci-2dgz-1013-qct2k1gp
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 1598: bb_post_scanjob returning with stat = [0]
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 284: http_close() handle=0x5612cd668610
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 561: released 7/1/4 interface
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 976: removed HP-IPP channel=45 clientCnt=0 channelCnt=0
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 249: http_open() dd=1 channel=HP-IPP handle=0x5612cd363060
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 961: new HP-IPP channel=45 clientCnt=1 channelCnt=1
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 427: Found interface conf=0, iface=1, altset=1, index=3
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 389: Active kernel driver on interface=1 ret=0
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 535: claimed 7/1/4 interface
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 1749: writing get scanner status request.
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 552: http_write() handle=0x5612cd668610 data=0x7fe234035260 size=49 sectime=5
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 815: bb_read_http_payload entry.
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 300: http_read_header() handle=0x5612cd668610 data=0x7fff8851d030 size=5120 sectime=5
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 166: read_channel len=1024
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 189: -read_stream() bytes_read=1 s.index=1 s.cnt=1023 stat=0
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 239: read_line len=17 index=17 cnt=1007
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 239: read_line len=31 index=48 cnt=976
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=31 total=48
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 239: read_line len=22 index=70 cnt=954
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=22 total=70
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 239: read_line len=52 index=122 cnt=902
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=52 total=122
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 239: read_line len=30 index=152 cnt=872
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=30 total=152
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 239: read_line len=24 index=176 cnt=848
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=24 total=176
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 239: read_line len=2 index=178 cnt=846
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=2 total=178
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 345: -http_read_header() handle=0x5612cd668610 data=0x7fff8851d030 bytes_read=178 size=5120 status=0
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 853: payload_length= (1545)
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 90: clear_stream entry...
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 97: Clearing (846) bytes from the stream
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 105: clear_stream returning with (stat = 0, bytes_read = 846)...
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 435: http_read2 entry.
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 439: http_read2 successful. (699 bytes read). 
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 919: bytes_remaining= 0 total=[1545] ret = [0].#012 
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 928: bb_read_http_payload completed. total=[1545] stat=[0] 
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 1445: bb_get_JobState jobid[wyivwwzz-50ci-2dgz-1013-qct2k1gp]
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 1482: bb_get_JobState: js=[Processing] jobstate=[4].
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 1783: jobstate =[4] version=[2]
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 1809: SANE_STATUS_COMPLETED or SANE_STATUS_PROCESSING.
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 1819: JOBSTATE [4].
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 284: http_close() handle=0x5612cd668610
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 561: released 7/1/4 interface
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 976: removed HP-IPP channel=45 clientCnt=0 channelCnt=0
Apr 22 22:39:41 jarno-MS-7817 hp-scan: bb_escl.c 1616: bb_get_scanjob..
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 249: http_open() dd=1 channel=HP-IPP handle=0x5612cd363060
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 961: new HP-IPP channel=45 clientCnt=1 channelCnt=1
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 427: Found interface conf=0, iface=1, altset=1, index=3
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 389: Active kernel driver on interface=1 ret=0
Apr 22 22:39:41 jarno-MS-7817 hp-scan: io/hpmud/musb.c 535: claimed 7/1/4 interface
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 552: http_write() handle=0x5612cd668610 data=0x7fff8851bbe0 size=90 sectime=1
Apr 22 22:39:41 jarno-MS-7817 hp-scan: http.c 300: http_read_header() handle=0x5612cd668610 data=0x7fff8851bbe0 size=5120 sectime=5
Apr 22 22:39:42 jarno-MS-7817 hp-scan: http.c 166: read_channel len=161
Apr 22 22:39:42 jarno-MS-7817 hp-scan: http.c 189: -read_stream() bytes_read=1 s.index=1 s.cnt=160 stat=0
Apr 22 22:39:42 jarno-MS-7817 hp-scan: http.c 239: read_line len=34 index=34 cnt=127
Apr 22 22:39:42 jarno-MS-7817 hp-scan: http.c 322: invalid http_status=503
Apr 22 22:39:42 jarno-MS-7817 hp-scan: http.c 328: dumping len=127
Apr 22 22:39:44 jarno-MS-7817 hp-scan: http.c 153: hpmud_read_channel failed retrying (2) more times)
Apr 22 22:39:45 jarno-MS-7817 hp-scan: http.c 153: hpmud_read_channel failed retrying (1) more times)
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 153: hpmud_read_channel failed retrying (0) more times)
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 157: read_stream error stat=49
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 189: -read_stream() bytes_read=0 s.index=0 s.cnt=0 stat=1
Apr 22 22:39:46 jarno-MS-7817 hp-scan: bb_escl.c 254: bb_get_content_length buf : 0
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 552: http_write() handle=0x5612cd668610 data=0x7fe234035260 size=49 sectime=5
Apr 22 22:39:46 jarno-MS-7817 hp-scan: bb_escl.c 815: bb_read_http_payload entry.
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 300: http_read_header() handle=0x5612cd668610 data=0x7fff8851a7e0 size=5120 sectime=5
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 166: read_channel len=1024
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 189: -read_stream() bytes_read=1 s.index=1 s.cnt=1023 stat=0
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 239: read_line len=17 index=17 cnt=1007
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 239: read_line len=31 index=48 cnt=976
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=31 total=48
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 239: read_line len=22 index=70 cnt=954
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=22 total=70
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 239: read_line len=52 index=122 cnt=902
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=52 total=122
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 239: read_line len=30 index=152 cnt=872
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=30 total=152
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 239: read_line len=24 index=176 cnt=848
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=24 total=176
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 239: read_line len=2 index=178 cnt=846
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=2 total=178
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 345: -http_read_header() handle=0x5612cd668610 data=0x7fff8851a7e0 bytes_read=178 size=5120 status=0
Apr 22 22:39:46 jarno-MS-7817 hp-scan: bb_escl.c 853: payload_length= (1545)
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 90: clear_stream entry...
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 97: Clearing (846) bytes from the stream
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 105: clear_stream returning with (stat = 0, bytes_read = 846)...
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 435: http_read2 entry.
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 439: http_read2 successful. (699 bytes read). 
Apr 22 22:39:46 jarno-MS-7817 hp-scan: bb_escl.c 919: bytes_remaining= 0 total=[1545] ret = [0].#012 
Apr 22 22:39:46 jarno-MS-7817 hp-scan: bb_escl.c 928: bb_read_http_payload completed. total=[1545] stat=[0] 
Apr 22 22:39:46 jarno-MS-7817 hp-scan: bb_escl.c 1700: bb_get_scanjob stat=[9] bytes_read=[1545].
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 284: http_close() handle=0x5612cd668610
Apr 22 22:39:46 jarno-MS-7817 hp-scan: io/hpmud/musb.c 561: released 7/1/4 interface
Apr 22 22:39:46 jarno-MS-7817 hp-scan: io/hpmud/musb.c 976: removed HP-IPP channel=45 clientCnt=0 channelCnt=0
Apr 22 22:39:46 jarno-MS-7817 hp-scan: bb_escl.c 1833: bb_start_scan returning with status ret = (9)
Apr 22 22:39:46 jarno-MS-7817 hp-scan: hp-scan[17987]: error: SANE: Error during device I/O (code=9)
Apr 22 22:39:46 jarno-MS-7817 hp-scan: scan/sane/escl.c 1089: escl_cancel...
Apr 22 22:39:46 jarno-MS-7817 hp-scan: bb_escl.c 1939: bb_end_scan(cancel_job=1)
Apr 22 22:39:46 jarno-MS-7817 hp-scan: bb_escl.c 988: bb_cancel_job entry. job_id=[wyivwwzz-50ci-2dgz-1013-qct2k1gp] url=[/eSCL/ScanJobs/wyivwwzz-50ci-2dgz-1013-qct2k1gp]
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 249: http_open() dd=1 channel=HP-EWS-LEDM handle=0x5612cd363060
Apr 22 22:39:46 jarno-MS-7817 hp-scan: io/hpmud/musb.c 961: new HP-EWS-LEDM channel=23 clientCnt=1 channelCnt=1
Apr 22 22:39:46 jarno-MS-7817 hp-scan: io/hpmud/musb.c 427: Found interface conf=0, iface=1, altset=0, index=9
Apr 22 22:39:46 jarno-MS-7817 hp-scan: io/hpmud/musb.c 389: Active kernel driver on interface=1 ret=0
Apr 22 22:39:46 jarno-MS-7817 hp-scan: io/hpmud/musb.c 535: claimed ff/4/1 interface
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 552: http_write() handle=0x5612cd6686c0 data=0x7fe234035260 size=49 sectime=5
Apr 22 22:39:46 jarno-MS-7817 hp-scan: bb_escl.c 815: bb_read_http_payload entry.
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 300: http_read_header() handle=0x5612cd6686c0 data=0x7fff8851d990 size=5120 sectime=5
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 166: read_channel len=1024
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 189: -read_stream() bytes_read=1 s.index=1 s.cnt=1023 stat=0
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 239: read_line len=17 index=17 cnt=1007
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 239: read_line len=31 index=48 cnt=976
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=31 total=48
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 239: read_line len=22 index=70 cnt=954
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=22 total=70
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 239: read_line len=52 index=122 cnt=902
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=52 total=122
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 239: read_line len=30 index=152 cnt=872
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=30 total=152
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 239: read_line len=24 index=176 cnt=848
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=24 total=176
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 239: read_line len=2 index=178 cnt=846
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=2 total=178
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 345: -http_read_header() handle=0x5612cd6686c0 data=0x7fff8851d990 bytes_read=178 size=5120 status=0
Apr 22 22:39:46 jarno-MS-7817 hp-scan: bb_escl.c 853: payload_length= (1545)
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 90: clear_stream entry...
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 97: Clearing (846) bytes from the stream
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 105: clear_stream returning with (stat = 0, bytes_read = 846)...
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 435: http_read2 entry.
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 439: http_read2 successful. (699 bytes read). 
Apr 22 22:39:46 jarno-MS-7817 hp-scan: bb_escl.c 919: bytes_remaining= 0 total=[1545] ret = [0].#012 
Apr 22 22:39:46 jarno-MS-7817 hp-scan: bb_escl.c 928: bb_read_http_payload completed. total=[1545] stat=[0] 
Apr 22 22:39:46 jarno-MS-7817 hp-scan: bb_escl.c 1011: bb_cancel_job GET_ESCL_SCANNER_STATUS ret=0 bytes_read=1545 
Apr 22 22:39:46 jarno-MS-7817 hp-scan: bb_escl.c 1445: bb_get_JobState jobid[wyivwwzz-50ci-2dgz-1013-qct2k1gp]
Apr 22 22:39:46 jarno-MS-7817 hp-scan: bb_escl.c 1482: bb_get_JobState: js=[Processing] jobstate=[4].
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 552: http_write() handle=0x5612cd6686c0 data=0x7fff8851d990 size=80 sectime=1
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 300: http_read_header() handle=0x5612cd6686c0 data=0x7fff8851d990 size=5120 sectime=5
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 166: read_channel len=144
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 189: -read_stream() bytes_read=1 s.index=1 s.cnt=143 stat=0
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 239: read_line len=17 index=17 cnt=127
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 239: read_line len=19 index=36 cnt=108
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=19 total=36
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 239: read_line len=52 index=88 cnt=56
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=52 total=88
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 239: read_line len=30 index=118 cnt=26
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=30 total=118
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 239: read_line len=24 index=142 cnt=2
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=24 total=142
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 239: read_line len=2 index=0 cnt=0
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 341: http_read_header data= len=2 total=144
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 345: -http_read_header() handle=0x5612cd6686c0 data=0x7fff8851d990 bytes_read=144 size=5120 status=0
Apr 22 22:39:46 jarno-MS-7817 hp-scan: bb_escl.c 1031: bb_cancel_job len=144 buf=HTTP/1.1 200 OK#015#012Content-Length: 0#015#012Cache-Control: no-cache, no-store, must-revalidate#015#012Server: ApolloLedmServer/1.0#015#012Connection: keep-alive#015#012#015#012
Apr 22 22:39:46 jarno-MS-7817 hp-scan: http.c 284: http_close() handle=0x5612cd6686c0
Apr 22 22:39:46 jarno-MS-7817 hp-scan: io/hpmud/musb.c 561: released ff/4/1 interface
Apr 22 22:39:46 jarno-MS-7817 hp-scan: io/hpmud/musb.c 976: removed HP-EWS-LEDM channel=23 clientCnt=0 channelCnt=0
Apr 22 22:39:46 jarno-MS-7817 hp-scan: bb_escl.c 1042: bb_cancel_job returning with status = [0].
Apr 22 22:39:46 jarno-MS-7817 hp-scan: io/hpmud/hpmud.c 373: device_cleanup: device uri=hp:/usb/HP_LaserJet_MFP_M28-M31?serial=VNC3B92743
Apr 22 22:39:46 jarno-MS-7817 hp-scan: io/hpmud/hpmud.c 385: device_cleanup: close device dd=1...
Apr 22 22:39:46 jarno-MS-7817 hp-scan: io/hpmud/hpmud.c 387: device_cleanup: done closing device dd=1
jarno@jarno-MS-7817:/var/log$