sr: [00:00.000000] log: libsigrok loglevel set to 5.
sr: [00:00.016210] backend: libsigrok 0.6.0-git-7718f3ca/4:0:0.
sr: [00:00.016278] backend: Libs: glib 2.64.3 (rt: 2.64.3/6403:3), libzip 1.6.1, libserialport 0.1.1/1:0:1 (rt: 0.1.1/1:0:1), libusb-1.0 1.0.23.11397 API 0x01000107.
sr: [00:00.016308] backend: Host: x86_64-apple-darwin19.4.0, little-endian.
sr: [00:00.016333] backend: SCPI backends: TCP, RPC, serial, USBTMC.
sr: [00:00.016354] backend: Firmware search paths:
sr: [00:00.016410] backend:  - /Users/tms/.local/share/sigrok-firmware
sr: [00:00.016435] backend:  - /usr/local/share/sigrok-firmware
sr: [00:00.016455] backend:  - /usr/local/share/sigrok-firmware
sr: [00:00.016476] backend:  - /usr/share/sigrok-firmware
sr: [00:00.016537] backend: Sanity-checking all drivers.
sr: [00:00.016569] backend: Sanity-checking all input modules.
sr: [00:00.016596] backend: Sanity-checking all output modules.
sr: [00:00.016620] backend: Sanity-checking all transform modules.
sr: [00:00.021104] scpi_usbtmc: Found USBTMC device (VID:PID = 1ab1:04ce, bus.address = 20.10).
sr: [00:00.021176] scpi: Opening USBTMC device usbtmc/20.10.
sr: [00:00.021350] usb: Found USB device (VID:PID = 1ab1:04ce, bus.address = 20.10).
sr: [00:00.021379] usb: Trying to open USB device 20.10.
sr: [00:00.021504] usb: Opened USB device (VID:PID = 1ab1:04ce, bus.address = 20.10).
sr: [00:00.021531] scpi_usbtmc: Interface 0 configuration 1.
sr: [00:00.021548] scpi_usbtmc: Interrupt EP 1
sr: [00:00.021568] scpi_usbtmc: Bulk IN EP 2
sr: [00:00.021584] scpi_usbtmc: Bulk OUT EP 3
sr: [00:00.022450] scpi_usbtmc: Device capabilities: SCPI, L4, T6, SR1, RL1, DT1
sr: [00:00.022487] scpi_usbtmc: Locking out local control.
sr: [00:00.023090] scpi_usbtmc: Successfully sent SCPI command: '*IDN?'.
sr: [00:00.023649] scpi: Got response: 'RIGOL TECHNOLOGIES,DS1054Z,DS1ZA220801351,00.04.04.SP4', length 54.
sr: [00:00.023710] scpi_usbtmc: Returning local control.
sr: [00:00.024114] usb: Closed USB device 20.10.
sr: [00:00.025331] hwdriver: Scan found 1 devices (rigol-ds).
sr: [00:00.025424] device: rigol-ds: Opening device instance.
sr: [00:00.025445] usb: Trying to open USB device 20.10.
sr: [00:00.025511] usb: Opened USB device (VID:PID = 1ab1:04ce, bus.address = 20.10).
sr: [00:00.025536] scpi_usbtmc: Interface 0 configuration 1.
sr: [00:00.025553] scpi_usbtmc: Interrupt EP 1
sr: [00:00.025569] scpi_usbtmc: Bulk IN EP 2
sr: [00:00.025589] scpi_usbtmc: Bulk OUT EP 3
sr: [00:00.026220] scpi_usbtmc: Device capabilities: SCPI, L4, T6, SR1, RL1, DT1
sr: [00:00.026251] scpi_usbtmc: Locking out local control.
sr: [00:00.026836] scpi_usbtmc: Successfully sent SCPI command: ':CHAN1:DISP?'.
sr: [00:00.027216] scpi: Got response: '1', length 1.
sr: [00:00.027409] scpi_usbtmc: Successfully sent SCPI command: ':CHAN2:DISP?'.
sr: [00:00.027774] scpi: Got response: '0', length 1.
sr: [00:00.027964] scpi_usbtmc: Successfully sent SCPI command: ':CHAN3:DISP?'.
sr: [00:00.028444] scpi: Got response: '0', length 1.
sr: [00:00.028629] scpi_usbtmc: Successfully sent SCPI command: ':CHAN4:DISP?'.
sr: [00:00.029158] scpi: Got response: '0', length 1.
sr: [00:00.029181] rigol-ds: Current analog channel state:
sr: [00:00.029198] rigol-ds: CH1 on
sr: [00:00.029214] rigol-ds: CH2 off
sr: [00:00.029230] rigol-ds: CH3 off
sr: [00:00.029246] rigol-ds: CH4 off
sr: [00:00.029424] scpi_usbtmc: Successfully sent SCPI command: ':TIM:SCAL?'.
sr: [00:00.029997] scpi: Got response: '1.0000000e-02', length 13.
sr: [00:00.030060] rigol-ds: Current timebase 0.01
sr: [00:00.030267] scpi_usbtmc: Successfully sent SCPI command: ':CHAN1:PROB?'.
sr: [00:00.030779] scpi: Got response: '1.000000e+01', length 12.
sr: [00:00.030953] scpi_usbtmc: Successfully sent SCPI command: ':CHAN2:PROB?'.
sr: [00:00.031488] scpi: Got response: '1.000000e+01', length 12.
sr: [00:00.031665] scpi_usbtmc: Successfully sent SCPI command: ':CHAN3:PROB?'.
sr: [00:00.032239] scpi: Got response: '1.000000e+01', length 12.
sr: [00:00.032420] scpi_usbtmc: Successfully sent SCPI command: ':CHAN4:PROB?'.
sr: [00:00.032989] scpi: Got response: '1.000000e+01', length 12.
sr: [00:00.033039] rigol-ds: Current probe attenuation:
sr: [00:00.033050] rigol-ds: CH1 10
sr: [00:00.033062] rigol-ds: CH2 10
sr: [00:00.033073] rigol-ds: CH3 10
sr: [00:00.033083] rigol-ds: CH4 10
sr: [00:00.033257] scpi_usbtmc: Successfully sent SCPI command: ':CHAN1:SCAL?'.
sr: [00:00.033729] scpi: Got response: '1.000000e+01', length 12.
sr: [00:00.033903] scpi_usbtmc: Successfully sent SCPI command: ':CHAN2:SCAL?'.
sr: [00:00.034330] scpi: Got response: '1.000000e+01', length 12.
sr: [00:00.034516] scpi_usbtmc: Successfully sent SCPI command: ':CHAN3:SCAL?'.
sr: [00:00.034956] scpi: Got response: '1.000000e+00', length 12.
sr: [00:00.035172] scpi_usbtmc: Successfully sent SCPI command: ':CHAN4:SCAL?'.
sr: [00:00.035555] scpi: Got response: '1.000000e+00', length 12.
sr: [00:00.035573] rigol-ds: Current vertical gain:
sr: [00:00.035583] rigol-ds: CH1 10
sr: [00:00.035594] rigol-ds: CH2 10
sr: [00:00.035605] rigol-ds: CH3 1
sr: [00:00.035616] rigol-ds: CH4 1
sr: [00:00.035780] scpi_usbtmc: Successfully sent SCPI command: ':CHAN1:OFFS?'.
sr: [00:00.036248] scpi: Got response: '5.599900e+00', length 12.
sr: [00:00.036452] scpi_usbtmc: Successfully sent SCPI command: ':CHAN2:OFFS?'.
sr: [00:00.036917] scpi: Got response: '-3.460000e+01', length 13.
sr: [00:00.037096] scpi_usbtmc: Successfully sent SCPI command: ':CHAN3:OFFS?'.
sr: [00:00.037517] scpi: Got response: '0.000000e+00', length 12.
sr: [00:00.037701] scpi_usbtmc: Successfully sent SCPI command: ':CHAN4:OFFS?'.
sr: [00:00.038199] scpi: Got response: '0.000000e+00', length 12.
sr: [00:00.038216] rigol-ds: Current vertical offset:
sr: [00:00.038227] rigol-ds: CH1 5.5999
sr: [00:00.038238] rigol-ds: CH2 -34.6
sr: [00:00.038249] rigol-ds: CH3 0
sr: [00:00.038259] rigol-ds: CH4 0
sr: [00:00.038425] scpi_usbtmc: Successfully sent SCPI command: ':CHAN1:COUP?'.
sr: [00:00.038800] scpi: Got response: 'DC', length 2.
sr: [00:00.038977] scpi_usbtmc: Successfully sent SCPI command: ':CHAN2:COUP?'.
sr: [00:00.039333] scpi: Got response: 'DC', length 2.
sr: [00:00.039518] scpi_usbtmc: Successfully sent SCPI command: ':CHAN3:COUP?'.
sr: [00:00.039927] scpi: Got response: 'DC', length 2.
sr: [00:00.040103] scpi_usbtmc: Successfully sent SCPI command: ':CHAN4:COUP?'.
sr: [00:00.040470] scpi: Got response: 'DC', length 2.
sr: [00:00.040486] rigol-ds: Current coupling:
sr: [00:00.040497] rigol-ds: CH1 DC
sr: [00:00.040507] rigol-ds: CH2 DC
sr: [00:00.040517] rigol-ds: CH3 DC
sr: [00:00.040528] rigol-ds: CH4 DC
sr: [00:00.040695] scpi_usbtmc: Successfully sent SCPI command: ':TRIG:EDGE:SOUR?'.
sr: [00:00.041144] scpi: Got response: 'CHAN1', length 5.
sr: [00:00.041172] rigol-ds: Current trigger source CHAN1
sr: [00:00.041291] scpi_usbtmc: Successfully sent SCPI command: ':TIM:OFFS?'.
sr: [00:00.041833] scpi: Got response: '0.0000000e+00', length 13.
sr: [00:00.041863] rigol-ds: Current horizontal trigger position 0
sr: [00:00.042029] scpi_usbtmc: Successfully sent SCPI command: ':TRIG:EDGE:SLOP?'.
sr: [00:00.042537] scpi: Got response: 'POS', length 3.
sr: [00:00.042554] rigol-ds: Current trigger slope POS
sr: [00:00.042721] scpi_usbtmc: Successfully sent SCPI command: ':TRIG:EDGE:LEV?'.
sr: [00:00.043316] scpi: Got response: '1.440000e+01', length 12.
sr: [00:00.043334] rigol-ds: Current trigger level 14.4
sr: [00:00.043401] hwdriver: sr_config_set(): key 50002 (limit_frames) sdi 0x7facdfc08f10 cg NULL -> uint64 1
sr: [00:00.043467] session: Using thread-default main context.
sr: [00:00.043480] session: Starting.
sr: [00:00.043490] hwdriver: rigol-ds: Starting acquisition.
sr: [00:00.043501] rigol-ds: handling channel CH1
sr: [00:00.043512] rigol-ds: handling channel CH2
sr: [00:00.043522] rigol-ds: handling channel CH3
sr: [00:00.043532] rigol-ds: handling channel CH4
sr: [00:00.043708] scpi_usbtmc: Successfully sent SCPI command: ':RUN'.
sr: [00:00.043875] scpi_usbtmc: Successfully sent SCPI command: '*OPC?'.
sr: [00:00.063350] scpi: Got response: '1', length 1.
sr: [00:00.063468] session: bus: Received SR_DF_HEADER packet.
cli: Received SR_DF_HEADER.
sr: [00:00.063577] hwdriver: sr_config_get(): key 30000 (samplerate) sdi 0x7facdfc08f10 cg NULL -> uint64 10000
sr: [00:00.063621] rigol-ds: Starting data capture for frameset 1 of 1
sr: [00:00.063981] scpi_usbtmc: Successfully sent SCPI command: ':WAV:FORM BYTE'.
sr: [00:00.064229] scpi_usbtmc: Successfully sent SCPI command: '*OPC?'.
sr: [00:00.112383] scpi: Got response: '1', length 1.
sr: [00:00.112647] scpi_usbtmc: Successfully sent SCPI command: ':WAV:MODE NORM'.
sr: [00:00.112895] scpi_usbtmc: Successfully sent SCPI command: '*OPC?'.
sr: [00:00.162664] scpi: Got response: '1', length 1.
sr: [00:00.162741] session: bus: Received SR_DF_FRAME_BEGIN packet.
cli: Received SR_DF_FRAME_BEGIN.
sr: [00:00.216152] rigol-ds: Sleeping for 101999 usecs instead of trigger-wait
sr: [00:00.322772] rigol-ds: Starting reading data from channel 1
sr: [00:00.323053] scpi_usbtmc: Successfully sent SCPI command: ':WAV:SOUR CHAN1'.
sr: [00:00.323288] scpi_usbtmc: Successfully sent SCPI command: '*OPC?'.
sr: [00:00.383358] scpi: Got response: '1', length 1.
sr: [00:00.383692] scpi_usbtmc: Successfully sent SCPI command: ':WAV:MODE NORM'.
sr: [00:00.383945] scpi_usbtmc: Successfully sent SCPI command: '*OPC?'.
sr: [00:00.432470] scpi: Got response: '1', length 1.
sr: [00:00.432746] scpi_usbtmc: Successfully sent SCPI command: ':WAV:YINC?'.
sr: [00:00.433393] scpi: Got response: '4.000000e-01', length 12.
sr: [00:00.433610] scpi_usbtmc: Successfully sent SCPI command: ':WAV:YOR?'.
sr: [00:00.434173] scpi: Got response: '13', length 2.
sr: [00:00.434363] scpi_usbtmc: Successfully sent SCPI command: ':WAV:YREF?'.
sr: [00:00.434909] scpi: Got response: '127', length 3.
sr: [00:00.435132] scpi_usbtmc: Successfully sent SCPI command: ':WAV:START 1'.
sr: [00:00.435310] scpi_usbtmc: Successfully sent SCPI command: '*OPC?'.
sr: [00:00.482592] scpi: Got response: '1', length 1.
sr: [00:00.482877] scpi_usbtmc: Successfully sent SCPI command: ':WAV:STOP 1200'.
sr: [00:00.483160] scpi_usbtmc: Successfully sent SCPI command: '*OPC?'.
sr: [00:00.539475] scpi: Got response: '1', length 1.
sr: [00:00.539750] scpi_usbtmc: Successfully sent SCPI command: ':WAV:DATA?'.
sr: [00:00.540631] rigol-ds: New block header expected
sr: [00:00.540672] rigol-ds: Received data block header: '#9000001200' -> block length 1200
sr: [00:00.540689] rigol-ds: Requesting read of 1200 bytes
sr: [00:00.540705] rigol-ds: Received 41 bytes.
sr: [00:00.540753] session: bus: Received SR_DF_ANALOG packet (41 samples).
cli: Received SR_DF_ANALOG (41 samples).
sr: [00:00.540800] hwdriver: sr_config_get(): key 30000 (samplerate) sdi 0x7facdfc08f10 cg NULL -> uint64 10000
sr: [00:00.544392] rigol-ds: 41 of 1200 block bytes read
sr: [00:00.544449] rigol-ds: Requesting read of 1159 bytes
sr: [00:00.544625] rigol-ds: Received 64 bytes.
sr: [00:00.544651] session: bus: Received SR_DF_ANALOG packet (64 samples).
cli: Received SR_DF_ANALOG (64 samples).
sr: [00:00.546228] rigol-ds: 105 of 1200 block bytes read
sr: [00:00.598999] rigol-ds: Requesting read of 1095 bytes
sr: [00:00.599226] rigol-ds: Received 64 bytes.
sr: [00:00.599272] session: bus: Received SR_DF_ANALOG packet (64 samples).
cli: Received SR_DF_ANALOG (64 samples).
sr: [00:00.601565] rigol-ds: 169 of 1200 block bytes read
sr: [00:00.653181] rigol-ds: Requesting read of 1031 bytes
sr: [00:00.653420] rigol-ds: Received 64 bytes.
sr: [00:00.653453] session: bus: Received SR_DF_ANALOG packet (64 samples).
cli: Received SR_DF_ANALOG (64 samples).
sr: [00:00.655581] rigol-ds: 233 of 1200 block bytes read
sr: [00:00.707758] rigol-ds: Requesting read of 967 bytes
sr: [00:00.708096] rigol-ds: Received 64 bytes.
sr: [00:00.708157] session: bus: Received SR_DF_ANALOG packet (64 samples).
cli: Received SR_DF_ANALOG (64 samples).
sr: [00:00.710513] rigol-ds: 297 of 1200 block bytes read
sr: [00:00.763092] rigol-ds: Requesting read of 903 bytes
sr: [00:00.763453] rigol-ds: Received 64 bytes.
sr: [00:00.763513] session: bus: Received SR_DF_ANALOG packet (64 samples).
cli: Received SR_DF_ANALOG (64 samples).
sr: [00:00.765935] rigol-ds: 361 of 1200 block bytes read
sr: [00:00.818193] rigol-ds: Requesting read of 839 bytes
sr: [00:00.818523] rigol-ds: Received 64 bytes.
sr: [00:00.818573] session: bus: Received SR_DF_ANALOG packet (64 samples).
cli: Received SR_DF_ANALOG (64 samples).
sr: [00:00.820458] rigol-ds: 425 of 1200 block bytes read
sr: [00:00.871943] rigol-ds: Requesting read of 775 bytes
sr: [00:00.872270] rigol-ds: Received 64 bytes.
sr: [00:00.872316] session: bus: Received SR_DF_ANALOG packet (64 samples).
cli: Received SR_DF_ANALOG (64 samples).
sr: [00:00.874180] rigol-ds: 489 of 1200 block bytes read
sr: [00:00.927147] rigol-ds: Requesting read of 711 bytes
sr: [00:00.927504] rigol-ds: Error while reading block data, aborting capture.
sr: [00:00.927537] session: bus: Received SR_DF_FRAME_END packet.
cli: Received SR_DF_FRAME_END.
sr: [00:00.927565] hwdriver: rigol-ds: Stopping acquisition.
sr: [00:00.927576] session: bus: Received SR_DF_END packet.
cli: Received SR_DF_END.
sr: [00:00.927608] usb: usb_source_finalize
sr: [00:00.927646] session: Stopped.
sr: [00:00.927669] hwdriver: Cleaning up all drivers.
sr: [00:00.927683] scpi_usbtmc: Returning local control.
sr: [00:00.928154] usb: Closed USB device 20.10.