Paylink -> CF7900 MDB

aurelien · Post by **aurelien** » Tue Mar 23, 2021 4:40 pm

Hello,

I am encountering some refund error with the CF7900 MDB.
Paylink Firmware Genoa-V4-1-12-12
CF7900 MDB V1.21.49
I used those functions: SetDispenseQuantity(..) and PaySpecific().

LastPayStatus is always equal to PAY_FINISHED. Even if I remove the cassete/Dispensebox (not this test)
In these test the paylink say it refund 3 coins of 20 infact the refund made is only 1 coin of 20

May you help me? thank you in advance.
---
Befor refund :
Recy id =0 value=200 CoinCount=15 count=0 inhibit=Yes
Recy id =1 value=100 CoinCount=16 count=4 inhibit=No
Recy id =2 value=50 CoinCount=41 count=66 inhibit=No
Recy id =3 value=20 CoinCount=1 count=6 inhibit=No
Recy id =4 value=10 CoinCount=11 count=0 inhibit=Yes

Refund ASK:
SetDispenseQuantity OK : value[100] dispeserNum[1] Number of Coin[2]
SetDispenseQuantity OK : value[50] dispeserNum[2] Number of Coin[6]
SetDispenseQuantity OK : value[20] dispeserNum[3] Number of Coin[3]

After refund :
RecyValue[200] Count befor[0] after[0] -> [0]
RecyValue[100] Count befor[4] after[6] -> [2]
RecyValue[50] Count befor[66] after[72] -> [6]
RecyValue[20] Count befor[6] after[9] -> [3]
RecyValue[10] Count befor[0] after[0] -> [0]

RecyValue[200] coinCount befor[15] after[15] -> [0]
RecyValue[100] coinCount befor[16] after[14] -> [2]
RecyValue[50] coinCount befor[41] after[35] -> [6]
RecyValue[20] coinCount befor[1] after[0] -> [1]
RecyValue[10] coinCount befor[11] after[11] -> [0]

CurrentPaid() diff show 560 infact the refund is : 520

----------------------------------------------------------------------------------------------------
Paylink.log:
15:42:21.169 04:25
23 March 2021 Driver:1.2.0.1
15:42:47.384 PC: Driver restart (after crash)
15:42:47.412 Timeout: read 5000, write 5000
15:42:47.412 FT2232C end points in 2 out 129
15:42:47.412 FTDI chip type : 3
15:42:47.412 Baudrate : 9600
15:42:47.412 Bitbang mode state : 0
15:42:47.412 FT2232C interface number : 0
15:42:47.412 FT2232C index number : 0
15:42:47.412 Bitbang mode : 1
15:42:47.412 EEPROM size : 128
15:42:47.518 Config: Start of download
15:42:47.518 Config: Checked, OK
15:42:47.518 Config: Paylink Checked OK against file "/etc/AES/Standard.cfg"
15:42:47.518 Exec: USB task took 16 msec
15:42:47.521 PC: Memory Reset - new protocol
15:42:47.756 DP: MDB acceptor 2080300 at ba0 and 5 coins setup
15:42:48.042 DP: Level 2 Tube Hopper S/N 559, Address 13, Value 200 at d34 setup
15:42:48.112 DP: Level 2 Tube Hopper S/N 559, Address 12, Value 100 at d80 setup
15:42:48.182 DP: Level 2 Tube Hopper S/N 559, Address 11, Value 50 at dcc setup
15:42:48.252 DP: Level 2 Tube Hopper S/N 559, Address 10, Value 20 at e18 setup
15:42:48.322 DP: Level 2 Tube Hopper S/N 559, Address 9, Value 10 at e64 setup
15:42:48.400 DP: Level 3 Payout System Hopper S/N 559, Address 8, Value 10 at eb0 setup
15:42:48.709 DP
15:42:48.709 PC: *** USB unit major memory reset ***
15:42:48.709
23 March 2021 Firmware: 1.1.12.83 from Feb 16 2018 at 13:55:29 Driver:1.2.0.1
15:42:48.709 : Interface memory set up
15:42:48.709 Exec: DP task took 1145 msec
15:43:09.664
15:43:09.664 Ver 001.001.012.083-526 Feb 16 2018 13:55:29
15:43:09.664 DP: Application active
15:43:09.664 DP: Interface memory recovery
15:43:09.664 DP: Resending Events
15:43:09.664 DP: Event 0000e0 for Acceptor 0
15:43:09.664 DP: Turn off barcodes
15:43:09.664 DP: Pay request for 560, (127195 - 126635 (3421363195 - 3421236000))
15:43:09.664 Exec: DP task took 10 msec
15:43:10.179 DP: Pay 560 (2 @ 100) from Level 2 Tube @ 12
15:43:10.179 DP: 360 left unqueued
15:43:10.179 MDB Tube@12: Pay 2 coins, value 100
15:43:11.715 MDB Tube@12: for 100 - Done
15:43:11.715 DP: 200 paid so far.
15:43:11.715 DP: Cycle End, 2 coins @ 100 status: 1
15:43:11.874 DP: Payout still owes 360, (127195 - 126835)
15:43:11.874 DP: Pay 360 (6 @ 50) from Level 2 Tube @ 11
15:43:11.874 DP: 60 left unqueued
15:43:11.874 Exec: DP task took 156 msec
15:43:11.874 MDB Tube@11: Pay 6 coins, value 50
15:43:14.725 MDB Tube@11: for 50 - Done
15:43:14.725 DP: 300 paid so far.
15:43:14.725 DP: Cycle End, 6 coins @ 50 status: 1
15:43:14.844 DP: Payout still owes 60, (127195 - 127135)
15:43:14.844 DP: Pay 60 (3 @ 20) from Level 2 Tube @ 10
15:43:14.844 Exec: DP task took 117 msec
15:43:14.844 MDB Tube@10: Pay 3 coins, value 20
15:43:15.715 MDB Tube@10: for 20 - Done
15:43:15.715 DP: 60 paid so far.
15:43:15.715 DP: Cycle End, 3 coins @ 20 status: 1
15:43:15.855 DP: Finished - overall status: 1, paid now 127195
15:43:15.855 Exec: DP task took 143 msec
15:43:15.979 MDB Tube@10: for 20 - reported coins 1=>0
15:43:15.979 MDB Tube@11: for 50 - reported coins 41=>35
15:43:15.979 MDB Tube@12: for 100 - reported coins 16=>14
15:43:16.014 Exec: DP task took 37 msec
15:43:18.643
15:43:18.644 DP: System closedown received
15:43:18.644 DP: No more updates
15:43:18.644
15:43:18.644 DP: Application has gone away
15:43:18.644
15:43:22.066 04:26

My log:
Value paid to date: 126635
----------CHANGER TUBE 0 (Adr=0)------------
Tube Description : Level 2 Tube
Tube Value=200
Tube Count=000
Tube CoinsCount : 15
Tube Coins status : -1
Tube SN : 559
Tube Status : -7
Tube Unit : x01090000
Tube Unit Address : 13
Tube Inhibit : Yes
----------CHANGER TUBE 1 (Adr=1)------------
Tube Description : Level 2 Tube
Tube Value=100
Tube Count=004
Tube CoinsCount : 16
Tube Coins status : -1
Tube SN : 559
Tube Status : 1
Tube Unit : x01090000
Tube Unit Address : 12
Tube Inhibit : No
----------CHANGER TUBE 2 (Adr=2)------------
Tube Description : Level 2 Tube
Tube Value=050
Tube Count=066
Tube CoinsCount : 41
Tube Coins status : -1
Tube SN : 559
Tube Status : 1
Tube Unit : x01090000
Tube Unit Address : 11
Tube Inhibit : No
----------CHANGER TUBE 3 (Adr=3)------------
Tube Description : Level 2 Tube
Tube Value=020
Tube Count=006
Tube CoinsCount : 1
Tube Coins status : -1
Tube SN : 559
Tube Status : 1
Tube Unit : x01090000
Tube Unit Address : 10
Tube Inhibit : No
----------CHANGER TUBE 4 (Adr=4)------------
Tube Description : Level 2 Tube
Tube Value=010
Tube Count=000
Tube CoinsCount : 11
Tube Coins status : -1
Tube SN : 559
Tube Status : -7
Tube Unit : x01090000
Tube Unit Address : 9
Tube Inhibit : Yes
----------CHANGER TUBE 5 (Adr=5)------------
Tube Description : Level 3 Payout System
Tube Value=010
Tube Count=000
Tube CoinsCount : 0
Tube Coins status : 0
Tube SN : 559
Tube Status : 1
Tube Unit : x01080000
Tube Unit Address : 8
Tube Inhibit : No
No changer id[6]
No changer id[7]
No changer id[8]
No changer id[9]
No changer id[10]
No changer id[11]
No changer id[12]
No changer id[13]
No changer id[14]
No changer id[15]
---------------------------------

SetDispenseQuantity OK : value[100] dispeserNum[1] Number of Coin[2]
SetDispenseQuantity OK : value[50] dispeserNum[2] Number of Coin[6]
SetDispenseQuantity OK : value[20] dispeserNum[3] Number of Coin[3]
Recy id =0 value=200 CoinCount=15 count=0 inhibit=Yes
Recy id =1 value=100 CoinCount=16 count=4 inhibit=No
Recy id =2 value=50 CoinCount=41 count=66 inhibit=No
Recy id =3 value=20 CoinCount=1 count=6 inhibit=No
Recy id =4 value=10 CoinCount=11 count=0 inhibit=Yes
Recy id =5 value=10 CoinCount=0 count=0 inhibit=No
End SetDispenseQuantity - Lauch PaySpecific
Now paid out: 200
Now paid out: 300
Now paid out: 60
FINISH paid out TOTAL refund 560
RecyValue[200] Count befor[0] after[0] -> [0]
RecyValue[100] Count befor[4] after[6] -> [2]
RecyValue[50] Count befor[66] after[72] -> [6]
RecyValue[20] Count befor[6] after[9] -> [3]
RecyValue[10] Count befor[0] after[0] -> [0]
RecyValue[200] coinCount befor[15] after[15] -> [0]
RecyValue[100] coinCount befor[16] after[14] -> [2]
RecyValue[50] coinCount befor[41] after[35] -> [6]
RecyValue[20] coinCount befor[1] after[0] -> [1]
RecyValue[10] coinCount befor[11] after[11] -> [0]

davebush · Post by **davebush** » Wed Mar 24, 2021 10:55 am

Hi,

I'm afraid that you have encountered a basic problem with using not just the CF7900 but any MDB changer.

The MDB protocol has two modes or operation, level 2 and level 3. Both of the modes have problems:
With the level 2 protocol you specify which tube / coin to pay from, but the changer does not report whether it worked. If a tube runs empty or faulty during the payout the changer can still only report the end of the attempt to pay, not whether it failed.
With the level 3 protocol you can only specify the total amount, the changer determines which coins to pay, but it does report accurately the actual coins paid out.

Our recommendation is that in normal use you only use the level 3 mode, and use the level 2 dispensers only for checking which coins have been paid.

You should only use level 2 / PaySpecific if you are doing things like dumping the coins from a specific tube, so any inaccuracy doesn't matter.

Regards

Dave

aurelien · Post by **aurelien** » Wed Mar 24, 2021 3:20 pm

Hello,

Thank you for the replay.

So the only solution for me to have a propre refund with specifique tube is to use inhibit and Payout() (I am correct ?).

I want to Dispense :
value[100] dispeserNum[1] Number of Coin[2]
value[50] dispeserNum[2] Number of Coin[6]
value[10] dispeserNum[4] Number of Coin[2]

refund 2 coins of 100 set inhibit=No only for value 100:
ReadDispenserDetails( .. ) befor the refund
Recy id =0 value=200 CoinCount=15 inhibit=Yes
Recy id =1 value=100 CoinCount=16 inhibit=No
Recy id =2 value=50 CoinCount=41 inhibit=Yes
Recy id =3 value=20 CoinCount=1 inhibit=Yes
Recy id =4 value=10 CoinCount=11 inhibit=Yes

payout(100)
..
check LastPayStatus() ..
..
if Paystatus == PAY_FINISHED
{
ReadDispenserDetails(..) and compare the dirrence with the ReadDispenserDetails made befor the refund to check the refund..
}

refund 6 coins of 50 set inhibit=No only for 50:
ReadDispenserDetails( .. ) befor the refund
Recy id =0 value=200 CoinCount=15 inhibit=Yes
Recy id =1 value=100 CoinCount=14 inhibit=Yes
Recy id =2 value=50 CoinCount=41 inhibit=No
Recy id =3 value=20 CoinCount=1 inhibit=Yes
Recy id =4 value=10 CoinCount=11 inhibit=Yes

payout(300)
..
check LastPayStatus() ..
..
if Paystatus == PAY_FINISHED
{
ReadDispenserDetails(..) and compare the dirrence with the ReadDispenserDetails made befor to check the refund..
}

refund 2 coins of 10 set inhibit=No only for 10:
ReadDispenserDetails( .. ) befor the refund
Recy id =0 value=200 CoinCount=15 inhibit=Yes
Recy id =1 value=100 CoinCount=14 inhibit=Yes
Recy id =2 value=50 CoinCount=35 inhibit=Yes
Recy id =3 value=20 CoinCount=1 inhibit=Yes
Recy id =4 value=10 CoinCount=11 inhibit=No

payout(20)
..
check LastPayStatus() ..
..
if Paystatus == PAY_FINISHED
{
ReadDispenserDetails(..) and compare the dirrence with the ReadDispenserDetails made befor to check the refund..
}

This would be the correct way? I will be able to detect LastPayStatus with error ?

davebush · Post by **davebush** » Wed Mar 24, 2021 5:47 pm

The idea of inhibiting the tubes is just another (more difficult) way of using the PaySpecfic command. Both techniques result in essentially the same messages sent to the changer, and you will never see an error reported by either method.

The only way to see an error reported if the payout fails is to use level 3 and let the changer choose the denominations.

However, your idea of using ReadDispenserDetails and checking the change in DispenserBlock.CoinCount might let you achieve error detection.

These values are not updated as a part of the payout, but will be updated "soon" after the payout is complete. (Probably less than 0.5 sec)

(The values you see here are those reported by the changer in response to one of the MDB protocol messages, not all changers report these accurately, some seem to take a wild guess.)

You will have to experiment with your CF7900 to see how accurate it is in error conditions.

aurelien · Post by **aurelien** » Tue Aug 17, 2021 12:45 pm

Hello,

as you recommand me I have change my software to use level 3 and let the changer choose the denominations.

last week, I encounter a problem. I ask a refund of 1800 (18€) and Paylink said to me refund done 2000 (20€) with coin of 2€. In fact e refund 9 coin of 2€.

---
13:54:06.927 MDB Payout@8: 20 units
13:54:06.927 DP: 1600 paid so far.

13:54:07.640 MDB Payout@8: 20 units
13:54:07.640 MDB Payout@8: 20 units
13:54:07.640 DP: 2000 paid so far.

13:54:07.641 MDB Payout@8: Paid 9 @ 200, Total 180 units, 0 not paid

13:54:07.708 DP: 1800 paid so far. why He said 1800 here it's too late I already take 2000 as refund !

13:54:07.708 DP: Cycle End

Could you help me.

Code: Select all

[b] /etc/AES/Standard.cfg[/b]
System

Driver
   Logfile "/var/log/Paylink.log"
   Run visible

Protocol cctalk on connector cctalk
   Hopper at 3 Value 50
   Hopper at 4 Value 100

Protocol MDB on connector MDB
   Changer at 08h

log init:

Code: Select all

Configuration file: /etc/AES/Standard.cfg
11 August 2021     Driver:1.2.0.1
11:45:18.719 PC: Driver start up
11:45:18.723 Timeout: read 5000, write 5000
11:45:18.723 FT2232C end points in 2 out 129
11:45:18.723 FTDI chip type           : 3
11:45:18.723 Baudrate                 : 9600
11:45:18.723 Bitbang mode state       : 0
11:45:18.723 FT2232C interface number : 0
11:45:18.723 FT2232C index number     : 0
11:45:18.723 Bitbang mode             : 1
11:45:18.723 EEPROM size              : 128

11:45:18.850 Config: Start of download
11:45:18.850 Config: Checked, OK
11:45:18.850 Config: Paylink Checked OK against file "/etc/AES/Standard.cfg"
11:45:18.850 Exec: USB task took 31 msec
11:45:18.851 PC: Memory Reset - new protocol

11:45:19.065 DP: MDB acceptor 2080300 at ba0 and 5 coins 
setup

11:45:19.332 DP: Level 2 Tube Hopper S/N 3299, Address 13, Value 200 at d34 setup

11:45:19.401 DP: Level 2 Tube Hopper S/N 3299, Address 12, Value 100 at d80 setup

11:45:19.470 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc setup

11:45:19.539 DP: Level 2 Tube Hopper S/N 3299, Address 11, Value 50 at e18 setup

11:45:19.608 DP: SUH1-USE_SERNR Hopper S/N 16777215, Address 3, Value 50 at e64 setup

11:45:19.677 DP: Level 2 Tube Hopper S/N 3299, Address 10, Value 20 at ebc setup

11:45:19.746 DP: Level 2 Tube Hopper S/N 3299, Address 9, Value 10 at f08 setup

11:45:19.822 DP: Level 3 Payout System Hopper S/N 3299, Address 8, Value 10 at f54 setup

11:45:20.117 DP

11:45:20.117 PC: *** USB unit major memory reset ***

11:45:20.117 
11 August 2021     Firmware: 1.1.12.83 from Feb 16 2018 at 13:55:29     Driver:1.2.0.1
11:45:20.117 : Interface memory set up
11:45:20.117 Exec: DP task took 1223 msec

11:45:41.077 454:18

11:45:45.014 ccHopper@4: Selftest OK

11:45:45.589 ccHopper@3: Selftest OK

11:46:12.086 
11:46:12.086 
11:46:12.086 Ver 001.001.012.083-526 Feb 16 2018 13:55:29
11:46:12.086 DP: Application active
11:46:12.086 DP: Interface memory recovery
11:46:12.086 DP: Event 0003
11:46:12.086 DP: Turn off barcodes

11:46:40.870 454:19

11:46:53.223 DP: Resending Events

11:46:53.461 DP: Event 0001

11:46:53.779 DP: Event 000060 for Dispenser 2

11:46:54.097 DP: Event 000060 for Dispenser 4

11:46:54.383 DP: Event 0002

11:46:54.701 DP: Event 0000e0 for Acceptor 0

11:46:54.987 DP: Event 000060 for Dispenser 2

11:46:55.305 DP: Event 000060 for Dispenser 4

11:47:13.547 cctalk:       0 < 00
11:47:13.547 cctalk:       3 > 04
11:47:13.547 cctalk:      14 < 00
11:47:13.547 cctalk:       3 > 04
11:47:13.547 cctalk: Timeout (90) for 166 to ccHopper @ 4
11:47:13.547 ccHopper@4: No response to message
11:47:13.547 Exec: cctalk task took 9 msec
11:47:13.547 ccHopper@4: Re-Identifying hopper

11:47:13.719 ccHopper@4: Hopper count 438 OK
11:47:13.719 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
11:47:13.719 Exec: cctalk task took 9 msec

11:47:40.651 454:20

11:48:40.437 454:21

11:49:22.106 cctalk:       0 < 00
11:49:22.106 cctalk:       3 > 04
11:49:22.106 cctalk:      13 < 00
11:49:22.106 cctalk:       3 > 04
11:49:22.106 cctalk: Timeout (90) for 166 to ccHopper @ 4
11:49:22.106 ccHopper@4: No response to message
11:49:22.106 Exec: cctalk task took 10 msec
11:49:22.106 ccHopper@4: Re-Identifying hopper

11:49:22.279 ccHopper@4: Hopper count 438 OK
11:49:22.279 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
11:49:22.279 Exec: cctalk task took 9 msec

11:49:40.228 454:22

11:50:37.856 cctalk:       0 < 00
11:50:37.856 cctalk:       3 > 04
11:50:37.856 cctalk:      13 < 00
11:50:37.856 cctalk:       3 > 04
11:50:37.856 cctalk: Timeout (90) for 166 to ccHopper @ 4
11:50:37.856 ccHopper@4: No response to message
11:50:37.856 Exec: cctalk task took 9 msec
11:50:37.856 ccHopper@4: Re-Identifying hopper

11:50:38.026 ccHopper@4: Hopper count 438 OK
11:50:38.026 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
11:50:38.026 Exec: cctalk task took 9 msec

11:50:40.012 454:23

11:51:39.801 454:24

11:51:58.455 DP: Switch 0: open 15, close 15

11:52:03.986 MDB: Selftest fail 15 02 => f2
11:52:03.986 DP: MDB Status to 44
11:52:03.986 DP: Event f200e1 for Acceptor 0

error :

Code: Select all

13:53:45.648 MDB: Enable
13:53:45.648 DP: MDB Status to 0
13:53:45.648 MDB: inhibits to 001f

13:53:57.263 MDB: Disable
13:53:57.263 DP: MDB Status to 4
13:53:57.263 MDB: Inhibit all coins

13:54:02.218 DP: Pay request for 1800, (396370 - 394570 (4133183665 - 4132787295))

13:54:02.737 DP: Pay 1800 (180 @ 10) from Level 3 Payout System @ 8
13:54:02.737 MDB Payout@8: Pay 180 units
13:54:02.737 MDB: Enable
13:54:02.737 DP: MDB Status to 0
13:54:02.737 MDB: inhibits to 001f

13:54:03.429 MDB Payout@8: 20 units
13:54:03.429 DP: 200 paid so far.

13:54:03.916 MDB Payout@8: 20 units
13:54:03.916 DP: 400 paid so far.

13:54:04.498 MDB Payout@8: 20 units
13:54:04.498 DP: 600 paid so far.

13:54:04.985 MDB Payout@8: 20 units
13:54:04.985 DP: 800 paid so far.

13:54:05.470 MDB Payout@8: 20 units
13:54:05.470 DP: 1000 paid so far.

13:54:05.955 MDB Payout@8: 20 units
13:54:05.955 DP: 1200 paid so far.

13:54:06.441 MDB Payout@8: 20 units
13:54:06.441 DP: 1400 paid so far.

13:54:06.927 MDB Payout@8: 20 units
13:54:06.927 DP: 1600 paid so far.

13:54:07.640 MDB Payout@8: 20 units
13:54:07.640 MDB Payout@8: 20 units
13:54:07.640 DP: 2000 paid so far.
13:54:07.641 MDB Payout@8: Paid 9 @ 200, Total 180 units, 0 not paid

13:54:07.708 DP: 1800 paid so far.
13:54:07.708 DP: Cycle End
, 180 coins @ 10 status: 1
13:54:07.847 DP:   Finished - overall status: 1, paid now 396370
13:54:07.847 Exec: DP task took 206 msec
13:54:07.847 MDB: Disable

all log:

Code: Select all

Configuration file: /etc/AES/Standard.cfg
11 August 2021     Driver:1.2.0.1
11:45:18.719 PC: Driver start up
11:45:18.723 Timeout: read 5000, write 5000
11:45:18.723 FT2232C end points in 2 out 129
11:45:18.723 FTDI chip type           : 3
11:45:18.723 Baudrate                 : 9600
11:45:18.723 Bitbang mode state       : 0
11:45:18.723 FT2232C interface number : 0
11:45:18.723 FT2232C index number     : 0
11:45:18.723 Bitbang mode             : 1
11:45:18.723 EEPROM size              : 128

11:45:18.850 Config: Start of download
11:45:18.850 Config: Checked, OK
11:45:18.850 Config: Paylink Checked OK against file "/etc/AES/Standard.cfg"
11:45:18.850 Exec: USB task took 31 msec
11:45:18.851 PC: Memory Reset - new protocol

11:45:19.065 DP: MDB acceptor 2080300 at ba0 and 5 coins 
setup

11:45:19.332 DP: Level 2 Tube Hopper S/N 3299, Address 13, Value 200 at d34 setup

11:45:19.401 DP: Level 2 Tube Hopper S/N 3299, Address 12, Value 100 at d80 setup

11:45:19.470 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc setup

11:45:19.539 DP: Level 2 Tube Hopper S/N 3299, Address 11, Value 50 at e18 setup

11:45:19.608 DP: SUH1-USE_SERNR Hopper S/N 16777215, Address 3, Value 50 at e64 setup

11:45:19.677 DP: Level 2 Tube Hopper S/N 3299, Address 10, Value 20 at ebc setup

11:45:19.746 DP: Level 2 Tube Hopper S/N 3299, Address 9, Value 10 at f08 setup

11:45:19.822 DP: Level 3 Payout System Hopper S/N 3299, Address 8, Value 10 at f54 setup

11:45:20.117 DP

11:45:20.117 PC: *** USB unit major memory reset ***

11:45:20.117 
11 August 2021     Firmware: 1.1.12.83 from Feb 16 2018 at 13:55:29     Driver:1.2.0.1
11:45:20.117 : Interface memory set up
11:45:20.117 Exec: DP task took 1223 msec

11:45:41.077 454:18

11:45:45.014 ccHopper@4: Selftest OK

11:45:45.589 ccHopper@3: Selftest OK

11:46:12.086 
11:46:12.086 
11:46:12.086 Ver 001.001.012.083-526 Feb 16 2018 13:55:29
11:46:12.086 DP: Application active
11:46:12.086 DP: Interface memory recovery
11:46:12.086 DP: Event 0003
11:46:12.086 DP: Turn off barcodes

11:46:40.870 454:19

11:46:53.223 DP: Resending Events

11:46:53.461 DP: Event 0001

11:46:53.779 DP: Event 000060 for Dispenser 2

11:46:54.097 DP: Event 000060 for Dispenser 4

11:46:54.383 DP: Event 0002

11:46:54.701 DP: Event 0000e0 for Acceptor 0

11:46:54.987 DP: Event 000060 for Dispenser 2

11:46:55.305 DP: Event 000060 for Dispenser 4

11:47:13.547 cctalk:       0 < 00
11:47:13.547 cctalk:       3 > 04
11:47:13.547 cctalk:      14 < 00
11:47:13.547 cctalk:       3 > 04
11:47:13.547 cctalk: Timeout (90) for 166 to ccHopper @ 4
11:47:13.547 ccHopper@4: No response to message
11:47:13.547 Exec: cctalk task took 9 msec
11:47:13.547 ccHopper@4: Re-Identifying hopper

11:47:13.719 ccHopper@4: Hopper count 438 OK
11:47:13.719 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
11:47:13.719 Exec: cctalk task took 9 msec

11:47:40.651 454:20

11:48:40.437 454:21

11:49:22.106 cctalk:       0 < 00
11:49:22.106 cctalk:       3 > 04
11:49:22.106 cctalk:      13 < 00
11:49:22.106 cctalk:       3 > 04
11:49:22.106 cctalk: Timeout (90) for 166 to ccHopper @ 4
11:49:22.106 ccHopper@4: No response to message
11:49:22.106 Exec: cctalk task took 10 msec
11:49:22.106 ccHopper@4: Re-Identifying hopper

11:49:22.279 ccHopper@4: Hopper count 438 OK
11:49:22.279 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
11:49:22.279 Exec: cctalk task took 9 msec

11:49:40.228 454:22

11:50:37.856 cctalk:       0 < 00
11:50:37.856 cctalk:       3 > 04
11:50:37.856 cctalk:      13 < 00
11:50:37.856 cctalk:       3 > 04
11:50:37.856 cctalk: Timeout (90) for 166 to ccHopper @ 4
11:50:37.856 ccHopper@4: No response to message
11:50:37.856 Exec: cctalk task took 9 msec
11:50:37.856 ccHopper@4: Re-Identifying hopper

11:50:38.026 ccHopper@4: Hopper count 438 OK
11:50:38.026 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
11:50:38.026 Exec: cctalk task took 9 msec

11:50:40.012 454:23

11:51:39.801 454:24

11:51:58.455 DP: Switch 0: open 15, close 15

11:52:03.986 MDB: Selftest fail 15 02 => f2
11:52:03.986 DP: MDB Status to 44
11:52:03.986 DP: Event f200e1 for Acceptor 0

11:52:15.599 MDB: Selftest OK
11:52:15.599 DP: MDB Status to 4
11:52:15.599 DP: Event 0000e0 for Acceptor 0

11:52:24.753 MDB Tube@10: for 20 - reported coins 3=>0

11:52:26.315 DP: Switch 0: open 15, close 16

11:52:39.589 454:25

11:53:01.535 cctalk:       0 < 00
11:53:01.535 cctalk:       3 > 04
11:53:01.535 cctalk:      13 < 00
11:53:01.535 cctalk:       3 > 04
11:53:01.535 cctalk: Timeout (90) for 166 to ccHopper @ 4
11:53:01.535 ccHopper@4: No response to message
11:53:01.535 Exec: cctalk task took 10 msec
11:53:01.535 ccHopper@4: Re-Identifying hopper

11:53:01.707 ccHopper@4: Hopper count 438 OK
11:53:01.707 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
11:53:01.707 Exec: cctalk task took 9 msec

11:53:39.382 454:26

11:54:39.153 454:27

11:55:11.829 MDB: Selftest OK
11:55:11.829 DP: Event 0000e0 for Acceptor 0

11:55:34.901 cctalk:       0 < 00
11:55:34.901 cctalk:       3 > 04
11:55:34.901 cctalk:      13 < 00
11:55:34.901 cctalk:       3 > 04
11:55:34.901 cctalk: Timeout (90) for 166 to ccHopper @ 4
11:55:34.901 ccHopper@4: No response to message
11:55:34.901 Exec: cctalk task took 9 msec
11:55:34.901 ccHopper@4: Re-Identifying hopper

11:55:35.076 ccHopper@4: Hopper count 438 OK
11:55:35.076 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
11:55:35.076 Exec: cctalk task took 10 msec

11:55:38.944 454:28

11:55:54.600 cctalk:       0 < 00
11:55:54.600 cctalk:       3 > 04
11:55:54.600 cctalk:      13 < 00
11:55:54.600 cctalk:       3 > 04
11:55:54.600 cctalk: Timeout (90) for 166 to ccHopper @ 4
11:55:54.600 ccHopper@4: No response to message
11:55:54.600 Exec: cctalk task took 9 msec
11:55:54.600 ccHopper@4: Re-Identifying hopper

11:55:54.774 ccHopper@4: Hopper count 438 OK
11:55:54.774 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
11:55:54.774 Exec: cctalk task took 9 msec

11:56:38.735 454:29

11:56:40.384 DP: Resending Events

11:56:40.656 DP: Event 0000e0 for Acceptor 0

11:56:40.974 DP: Event 000060 for Dispenser 2

11:56:41.292 DP: Event 000060 for Dispenser 4

11:57:38.517 454:30

11:57:42.267 DP: Switch 0: open 17, close 17

11:57:49.224 MDB: Selftest fail 15 02 => f2
11:57:49.224 DP: MDB Status to 44
11:57:49.224 DP: Event f200e1 for Acceptor 0

11:57:57.824 MDB: Selftest OK
11:57:57.824 DP: MDB Status to 4
11:57:57.824 DP: Event 0000e0 for Acceptor 0

11:58:06.976 MDB Tube@12: for 100 - reported coins 23=>28

11:58:11.226 DP: Switch 0: open 17, close 18

11:58:38.301 454:31

11:58:47.386 cctalk:       0 < 00
11:58:47.386 cctalk:       3 > 04
11:58:47.386 cctalk:      13 < 00
11:58:47.386 cctalk:       3 > 04
11:58:47.386 cctalk: Timeout (90) for 166 to ccHopper @ 4
11:58:47.386 ccHopper@4: No response to message
11:58:47.386 Exec: cctalk task took 9 msec
11:58:47.386 ccHopper@4: Re-Identifying hopper

11:58:47.557 ccHopper@4: Hopper count 438 OK
11:58:47.557 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
11:58:47.557 Exec: cctalk task took 9 msec

11:59:38.090 454:32

11 August 2021     Firmware: 1.1.12.83 from Feb 16 2018 at 13:55:29     Driver:1.2.0.1
12:00:28.998 cctalk:       0 < 00
12:00:28.998 cctalk:       3 > 04
12:00:28.998 cctalk:      13 < 00
12:00:28.998 cctalk:       3 > 04
12:00:28.998 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:00:28.998 ccHopper@4: No response to message
12:00:28.998 Exec: cctalk task took 9 msec
12:00:28.998 ccHopper@4: Re-Identifying hopper

12:00:29.173 ccHopper@4: Hopper count 438 OK
12:00:29.173 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:00:29.173 Exec: cctalk task took 9 msec

12:00:37.868 454:33

12:01:37.670 454:34

12:02:05.243 cctalk:       0 < 00
12:02:05.243 cctalk:       3 > 04
12:02:05.243 cctalk:      14 < 00
12:02:05.243 cctalk:       3 > 04
12:02:05.243 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:02:05.243 ccHopper@4: No response to message
12:02:05.243 Exec: cctalk task took 9 msec
12:02:05.243 ccHopper@4: Re-Identifying hopper

12:02:05.418 ccHopper@4: Hopper count 438 OK
12:02:05.418 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:02:05.418 Exec: cctalk task took 10 msec

12:02:09.814 cctalk:       0 < 00
12:02:09.814 cctalk:       3 > 03
12:02:09.814 cctalk:      16 < 00
12:02:09.814 cctalk:     463 > 04
12:02:09.814 cctalk: Timeout (90) for 217 to ccHopper @ 4
12:02:09.814 ccHopper@4: No response to message
12:02:09.814 Exec: cctalk task took 10 msec

12:02:09.862 ccHopper@4: Re-Identifying hopper

12:02:10.036 ccHopper@4: Hopper count 438 OK
12:02:10.036 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:02:10.036 Exec: cctalk task took 9 msec

12:02:34.956 cctalk:       0 < 00
12:02:34.956 cctalk:       3 > 04
12:02:34.956 cctalk:      13 < 00
12:02:34.956 cctalk:       3 > 04
12:02:34.957 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:02:34.957 ccHopper@4: No response to message
12:02:34.957 Exec: cctalk task took 9 msec
12:02:34.957 ccHopper@4: Re-Identifying hopper

12:02:35.130 ccHopper@4: Hopper count 438 OK
12:02:35.130 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:02:35.130 Exec: cctalk task took 9 msec

12:02:37.451 454:35

12:03:37.222 454:36

12:04:11.200 cctalk:       0 < 00
12:04:11.200 cctalk:       3 > 04
12:04:11.200 cctalk:      13 < 00
12:04:11.200 cctalk:       3 > 04
12:04:11.200 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:04:11.200 ccHopper@4: No response to message
12:04:11.200 Exec: cctalk task took 9 msec
12:04:11.200 ccHopper@4: Re-Identifying hopper

12:04:11.375 ccHopper@4: Hopper count 438 OK
12:04:11.375 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:04:11.375 Exec: cctalk task took 10 msec

12:04:37.009 454:37

12:05:23.725 cctalk:       0 < 00
12:05:23.725 cctalk:       3 > 04
12:05:23.725 cctalk:      13 < 00
12:05:23.725 cctalk:       3 > 04
12:05:23.725 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:05:23.725 ccHopper@4: No response to message
12:05:23.725 Exec: cctalk task took 9 msec
12:05:23.725 ccHopper@4: Re-Identifying hopper

12:05:23.900 ccHopper@4: Hopper count 438 OK
12:05:23.900 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:05:23.900 Exec: cctalk task took 10 msec

12:05:36.805 454:38

12:06:36.577 454:39

12:07:02.464 DP: Switch 0: open 19, close 19

12:07:07.933 MDB: Selftest fail 15 02 => f2
12:07:07.933 DP: MDB Status to 44
12:07:07.933 DP: Event f200e1 for Acceptor 0

12:07:09.645 cctalk:       0 < 00
12:07:09.645 cctalk:       3 > 04
12:07:09.645 cctalk:      13 < 00
12:07:09.645 cctalk:       3 > 04
12:07:09.645 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:07:09.645 ccHopper@4: No response to message
12:07:09.645 Exec: cctalk task took 9 msec
12:07:09.645 ccHopper@4: Re-Identifying hopper

12:07:09.820 ccHopper@4: Hopper count 438 OK
12:07:09.820 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:07:09.820 Exec: cctalk task took 10 msec

12:07:10.136 MDB: Selftest OK
12:07:10.136 DP: MDB Status to 4
12:07:10.136 DP: Event 0000e0 for Acceptor 0

12:07:15.346 DP: Switch 0: open 19, close 20

12:07:20.818 MDB Tube@10: for 20 - reported coins 0=>4

12:07:36.365 454:40

12:07:42.286 cctalk:       0 < 00
12:07:42.286 cctalk:       3 > 04
12:07:42.286 cctalk:      13 < 00
12:07:42.286 cctalk:       3 > 04
12:07:42.286 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:07:42.286 ccHopper@4: No response to message
12:07:42.286 Exec: cctalk task took 9 msec
12:07:42.286 ccHopper@4: Re-Identifying hopper

12:07:42.459 ccHopper@4: Hopper count 438 OK
12:07:42.459 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:07:42.459 Exec: cctalk task took 9 msec

12:08:36.146 454:41

12:08:52.655 cctalk:       0 < 00
12:08:52.655 cctalk:       3 > 04
12:08:52.655 cctalk:      13 < 00
12:08:52.655 cctalk:       3 > 04
12:08:52.655 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:08:52.655 ccHopper@4: No response to message
12:08:52.655 Exec: cctalk task took 9 msec
12:08:52.655 ccHopper@4: Re-Identifying hopper

12:08:52.827 ccHopper@4: Hopper count 438 OK
12:08:52.827 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:08:52.827 Exec: cctalk task took 9 msec

12:09:35.946 454:42

12:10:35.717 454:43

12:11:27.097 cctalk:       0 < 00
12:11:27.097 cctalk:       3 > 04
12:11:27.097 cctalk:      13 < 00
12:11:27.097 cctalk:       3 > 04
12:11:27.097 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:11:27.097 ccHopper@4: No response to message
12:11:27.097 Exec: cctalk task took 10 msec
12:11:27.097 ccHopper@4: Re-Identifying hopper

12:11:27.254 ccHopper@4: Hopper count 438 OK
12:11:27.254 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:11:27.254 Exec: cctalk task took 9 msec

12:11:35.516 454:44

12:12:35.287 454:45

12:13:35.074 454:46

12:14:32.719 cctalk:       0 < 00
12:14:32.719 cctalk:       3 > 03
12:14:32.719 cctalk:      17 < 00
12:14:32.719 cctalk:     463 > 04
12:14:32.719 cctalk: Timeout (90) for 217 to ccHopper @ 4
12:14:32.719 ccHopper@4: No response to message
12:14:32.719 Exec: cctalk task took 9 msec

12:14:32.783 ccHopper@4: Re-Identifying hopper

12:14:32.938 ccHopper@4: Hopper count 438 OK
12:14:32.938 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:14:32.938 Exec: cctalk task took 9 msec

12:14:34.859 454:47

12:14:54.624 cctalk:       0 < 00
12:14:54.624 cctalk:       3 > 04
12:14:54.624 cctalk:      13 < 00
12:14:54.624 cctalk:       3 > 04
12:14:54.624 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:14:54.624 ccHopper@4: No response to message
12:14:54.624 Exec: cctalk task took 10 msec
12:14:54.624 ccHopper@4: Re-Identifying hopper

12:14:54.798 ccHopper@4: Hopper count 438 OK
12:14:54.798 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:14:54.798 Exec: cctalk task took 9 msec

12:15:08.324 ccHopper@3: Selftest OK
12:15:08.324 DP: Event 000060 for Dispenser 4

12:15:08.830 ccHopper@4: Selftest OK
12:15:08.830 DP: Event 000060 for Dispenser 2

12:15:16.482 cctalk:       0 < 00
12:15:16.482 cctalk:       3 > 04
12:15:16.482 cctalk:      13 < 00
12:15:16.482 cctalk:       3 > 04
12:15:16.482 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:15:16.482 ccHopper@4: No response to message
12:15:16.482 Exec: cctalk task took 9 msec
12:15:16.482 ccHopper@4: Re-Identifying hopper

12:15:16.656 ccHopper@4: Hopper count 438 OK
12:15:16.656 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:15:16.656 Exec: cctalk task took 10 msec

12:15:34.653 454:48

12:16:34.440 454:49

12:17:09.966 cctalk:       0 < 00
12:17:09.966 cctalk:       3 > 04
12:17:09.966 cctalk:      13 < 00
12:17:09.966 cctalk:       3 > 04
12:17:09.966 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:17:09.966 ccHopper@4: No response to message
12:17:09.966 Exec: cctalk task took 9 msec
12:17:09.966 ccHopper@4: Re-Identifying hopper

12:17:10.141 ccHopper@4: Hopper count 438 OK
12:17:10.141 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:17:10.141 Exec: cctalk task took 10 msec

12:17:34.222 454:50

12:18:34.009 454:51

12:19:33.780 454:52

12:20:33.567 454:53

12:21:33.354 454:54

12:22:33.141 454:55

12:22:56.233 cctalk:       0 < 00
12:22:56.233 cctalk:       3 > 04
12:22:56.233 cctalk:      13 < 00
12:22:56.233 cctalk:       3 > 04
12:22:56.233 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:22:56.233 ccHopper@4: No response to message
12:22:56.233 Exec: cctalk task took 9 msec
12:22:56.233 ccHopper@4: Re-Identifying hopper

12:22:56.407 ccHopper@4: Hopper count 438 OK
12:22:56.407 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:22:56.407 Exec: cctalk task took 10 msec

12:22:58.507 MDB: Selftest OK
12:22:58.507 DP: Event 0000e0 for Acceptor 0

12:23:01.882 cctalk:       0 < 00
12:23:01.882 cctalk:       3 > 03
12:23:01.882 cctalk:      16 < 00
12:23:01.882 cctalk:     463 > 04
12:23:01.882 cctalk: Timeout (90) for 217 to ccHopper @ 4
12:23:01.882 ccHopper@4: No response to message
12:23:01.882 Exec: cctalk task took 9 msec

12:23:01.930 ccHopper@4: Re-Identifying hopper

12:23:02.104 ccHopper@4: Hopper count 438 OK
12:23:02.104 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:23:02.105 Exec: cctalk task took 9 msec

12:23:32.927 454:56

12:23:46.415 cctalk:       0 < 00
12:23:46.415 cctalk:       3 > 04
12:23:46.415 cctalk:      13 < 00
12:23:46.416 cctalk:       3 > 04
12:23:46.416 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:23:46.416 ccHopper@4: No response to message
12:23:46.416 Exec: cctalk task took 9 msec
12:23:46.416 ccHopper@4: Re-Identifying hopper

12:23:46.588 ccHopper@4: Hopper count 438 OK
12:23:46.588 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:23:46.588 Exec: cctalk task took 9 msec

12:24:32.717 454:57

12:25:32.504 454:58

12:25:51.740 cctalk:       0 < 00
12:25:51.740 cctalk:       3 > 04
12:25:51.740 cctalk:      13 < 00
12:25:51.740 cctalk:       3 > 04
12:25:51.740 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:25:51.740 ccHopper@4: No response to message
12:25:51.740 Exec: cctalk task took 9 msec
12:25:51.740 ccHopper@4: Re-Identifying hopper

12:25:51.910 ccHopper@4: Hopper count 438 OK
12:25:51.910 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:25:51.910 Exec: cctalk task took 9 msec

12:26:32.275 454:59

12:27:32.063 455:00

12:28:31.850 455:01

12:29:31.637 455:02

12:30:31.424 455:03

12:31:17.533 cctalk:       0 < 00
12:31:17.533 cctalk:       3 > 04
12:31:17.533 cctalk:      14 < 00
12:31:17.533 cctalk:       3 > 04
12:31:17.533 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:31:17.533 ccHopper@4: No response to message
12:31:17.533 Exec: cctalk task took 9 msec
12:31:17.533 ccHopper@4: Re-Identifying hopper

12:31:17.707 ccHopper@4: Hopper count 438 OK
12:31:17.707 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:31:17.707 Exec: cctalk task took 9 msec

12:31:31.205 455:04

12:32:22.509 cctalk:       0 < 00
12:32:22.509 cctalk:       3 > 04
12:32:22.509 cctalk:      13 < 00
12:32:22.509 cctalk:       3 > 04
12:32:22.509 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:32:22.509 ccHopper@4: No response to message
12:32:22.509 Exec: cctalk task took 9 msec
12:32:22.509 ccHopper@4: Re-Identifying hopper

12:32:22.680 ccHopper@4: Hopper count 438 OK
12:32:22.680 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:32:22.680 Exec: cctalk task took 9 msec

12:32:30.990 455:05

12:33:16.703 cctalk:       0 < 00
12:33:16.703 cctalk:       3 > 04
12:33:16.703 cctalk:      13 < 00
12:33:16.703 cctalk:       3 > 04
12:33:16.703 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:33:16.703 ccHopper@4: No response to message
12:33:16.703 Exec: cctalk task took 9 msec
12:33:16.703 ccHopper@4: Re-Identifying hopper

12:33:16.877 ccHopper@4: Hopper count 438 OK
12:33:16.877 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:33:16.877 Exec: cctalk task took 10 msec

12:33:27.787 cctalk:       0 < 00
12:33:27.787 cctalk:       3 > 04
12:33:27.787 cctalk:      13 < 00
12:33:27.787 cctalk:       3 > 04
12:33:27.787 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:33:27.787 ccHopper@4: No response to message
12:33:27.787 Exec: cctalk task took 9 msec
12:33:27.787 ccHopper@4: Re-Identifying hopper

12:33:27.959 ccHopper@4: Hopper count 438 OK
12:33:27.959 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:33:27.959 Exec: cctalk task took 9 msec

12:33:30.777 455:06

12:34:30.565 455:07

12:35:22.337 cctalk:       0 < 00
12:35:22.337 cctalk:       3 > 04
12:35:22.337 cctalk:      13 < 00
12:35:22.337 cctalk:       3 > 04
12:35:22.337 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:35:22.337 ccHopper@4: No response to message
12:35:22.337 Exec: cctalk task took 9 msec
12:35:22.337 ccHopper@4: Re-Identifying hopper

12:35:22.508 ccHopper@4: Hopper count 438 OK
12:35:22.508 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:35:22.508 Exec: cctalk task took 10 msec

12:35:30.338 455:08

12:36:30.126 455:09

12:37:23.350 cctalk:       0 < 00
12:37:23.350 cctalk:       3 > 04
12:37:23.350 cctalk:      13 < 00
12:37:23.350 cctalk:       3 > 04
12:37:23.350 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:37:23.350 ccHopper@4: No response to message
12:37:23.350 Exec: cctalk task took 9 msec
12:37:23.350 ccHopper@4: Re-Identifying hopper

12:37:23.525 ccHopper@4: Hopper count 438 OK
12:37:23.525 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:37:23.525 Exec: cctalk task took 9 msec

12:37:29.914 455:10

12:38:29.701 455:11

12:38:36.898 cctalk:       0 < 00
12:38:36.898 cctalk:       3 > 03
12:38:36.898 cctalk:      16 < 00
12:38:36.898 cctalk:     463 > 04
12:38:36.898 cctalk: Timeout (90) for 217 to ccHopper @ 4
12:38:36.898 ccHopper@4: No response to message
12:38:36.898 Exec: cctalk task took 9 msec

12:38:36.946 ccHopper@4: Re-Identifying hopper

12:38:37.119 ccHopper@4: Hopper count 438 OK
12:38:37.119 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:38:37.119 Exec: cctalk task took 10 msec

12:39:29.476 455:12

12:39:52.690 cctalk:       0 < 00
12:39:52.690 cctalk:       3 > 04
12:39:52.690 cctalk:      13 < 00
12:39:52.690 cctalk:       3 > 04
12:39:52.690 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:39:52.690 ccHopper@4: No response to message
12:39:52.690 Exec: cctalk task took 9 msec
12:39:52.690 ccHopper@4: Re-Identifying hopper

12:39:52.865 ccHopper@4: Hopper count 438 OK
12:39:52.865 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:39:52.865 Exec: cctalk task took 10 msec

12:40:29.259 455:13

12:41:29.046 455:14

12:41:48.323 cctalk:       0 < 00
12:41:48.323 cctalk:       3 > 04
12:41:48.323 cctalk:      13 < 00
12:41:48.323 cctalk:       3 > 04
12:41:48.323 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:41:48.323 ccHopper@4: No response to message
12:41:48.323 Exec: cctalk task took 9 msec
12:41:48.323 ccHopper@4: Re-Identifying hopper

12:41:48.498 ccHopper@4: Hopper count 438 OK
12:41:48.498 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:41:48.498 Exec: cctalk task took 10 msec

12:42:28.832 455:15

12:42:51.094 cctalk:       0 < 00
12:42:51.094 cctalk:       3 > 03
12:42:51.094 cctalk:      17 < 00
12:42:51.094 cctalk:     463 > 04
12:42:51.094 cctalk: Timeout (90) for 217 to ccHopper @ 4
12:42:51.094 ccHopper@4: No response to message
12:42:51.094 Exec: cctalk task took 9 msec

12:42:51.201 cctalk:       0 > 04
12:42:51.201 cctalk:      99 > 04
12:42:51.201 cctalk:      12 < 00
12:42:51.201 cctalk:       0 > 04
12:42:51.201 cctalk: Timeout (90) for 163 to ccHopper @ 4

12:42:51.249 ccHopper@4: Re-Identifying hopper

12:42:51.412 ccHopper@4: Hopper count 438 OK
12:42:51.412 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:42:51.412 Exec: cctalk task took 9 msec

12:43:28.623 455:16

12:44:28.427 455:17

12:44:32.238 ccHopper@3: Selftest OK
12:44:32.238 DP: Event 000060 for Dispenser 4

12:44:32.744 ccHopper@4: Selftest OK
12:44:32.744 DP: Event 000060 for Dispenser 2

12:44:37.168 cctalk:       0 < 00
12:44:37.168 cctalk:       3 > 04
12:44:37.168 cctalk:      13 < 00
12:44:37.168 cctalk:       3 > 04
12:44:37.168 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:44:37.168 ccHopper@4: No response to message
12:44:37.168 Exec: cctalk task took 9 msec
12:44:37.168 ccHopper@4: Re-Identifying hopper

12:44:37.342 ccHopper@4: Hopper count 438 OK
12:44:37.342 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:44:37.342 Exec: cctalk task took 10 msec

12:45:28.179 455:18

12:46:15.551 cctalk:       0 < 00
12:46:15.551 cctalk:       3 > 04
12:46:15.551 cctalk:      13 < 00
12:46:15.551 cctalk:       3 > 04
12:46:15.551 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:46:15.551 ccHopper@4: No response to message
12:46:15.551 Exec: cctalk task took 9 msec
12:46:15.551 ccHopper@4: Re-Identifying hopper

12:46:15.722 ccHopper@4: Hopper count 438 OK
12:46:15.722 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:46:15.722 Exec: cctalk task took 9 msec

12:46:17.962 cctalk:       0 < 00
12:46:17.962 cctalk:       3 > 03
12:46:17.962 cctalk:      17 < 00
12:46:17.962 cctalk:     463 > 04
12:46:17.962 cctalk: Timeout (90) for 217 to ccHopper @ 4
12:46:17.962 ccHopper@4: No response to message

12:46:17.962 Exec: cctalk task took 9 msec

12:46:18.010 ccHopper@4: Re-Identifying hopper

12:46:18.182 ccHopper@4: Hopper count 438 OK
12:46:18.182 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:46:18.182 Exec: cctalk task took 10 msec

12:46:27.965 455:19

12:47:16.533 cctalk:       0 < 00
12:47:16.533 cctalk:       3 > 04
12:47:16.533 cctalk:      13 < 00
12:47:16.533 cctalk:       3 > 04
12:47:16.533 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:47:16.533 ccHopper@4: No response to message
12:47:16.533 Exec: cctalk task took 9 msec
12:47:16.533 ccHopper@4: Re-Identifying hopper

12:47:16.705 ccHopper@4: Hopper count 438 OK
12:47:16.706 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:47:16.706 Exec: cctalk task took 9 msec

12:47:27.753 455:20

12:48:27.541 455:21

12:49:27.312 455:22

12:49:59.574 cctalk:       0 < 00
12:49:59.574 cctalk:       3 > 04
12:49:59.574 cctalk:      13 < 00
12:49:59.574 cctalk:       3 > 04
12:49:59.574 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:49:59.574 ccHopper@4: No response to message
12:49:59.574 Exec: cctalk task took 9 msec
12:49:59.574 ccHopper@4: Re-Identifying hopper

12:49:59.748 ccHopper@4: Hopper count 438 OK
12:49:59.748 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:49:59.748 Exec: cctalk task took 10 msec

12:50:14.981 cctalk:       0 < 00
12:50:14.981 cctalk:       3 > 04
12:50:14.981 cctalk:      13 < 00
12:50:14.981 cctalk:       3 > 04
12:50:14.981 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:50:14.981 ccHopper@4: No response to message
12:50:14.981 Exec: cctalk task took 9 msec
12:50:14.981 ccHopper@4: Re-Identifying hopper

12:50:15.140 ccHopper@4: Hopper count 438 OK
12:50:15.140 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:50:15.140 Exec: cctalk task took 10 msec

12:50:27.100 455:23

12:50:45.520 MDB: Selftest OK
12:50:45.520 DP: Event 0000e0 for Acceptor 0

12:51:26.894 455:24

12:52:26.665 455:25

12:52:27.856 cctalk:       0 < 00
12:52:27.856 cctalk:       3 > 04
12:52:27.856 cctalk:      13 < 00
12:52:27.856 cctalk:       3 > 04
12:52:27.856 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:52:27.856 ccHopper@4: No response to message
12:52:27.856 Exec: cctalk task took 10 msec
12:52:27.857 ccHopper@4: Re-Identifying hopper

12:52:28.028 ccHopper@4: Hopper count 438 OK
12:52:28.029 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:52:28.029 Exec: cctalk task took 9 msec

12:52:36.778 cctalk:       0 < 00
12:52:36.778 cctalk:       3 > 04
12:52:36.778 cctalk:      13 < 00
12:52:36.778 cctalk:       3 > 04
12:52:36.778 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:52:36.778 ccHopper@4: No response to message
12:52:36.778 Exec: cctalk task took 9 msec
12:52:36.778 ccHopper@4: Re-Identifying hopper

12:52:36.950 ccHopper@4: Hopper count 438 OK
12:52:36.950 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:52:36.950 Exec: cctalk task took 9 msec

12:53:26.458 455:26

12:54:26.245 455:27

12:55:26.017 455:28

12:56:25.804 455:29

12:57:20.497 cctalk:       0 < 00
12:57:20.497 cctalk:       3 > 03
12:57:20.497 cctalk:      17 < 00
12:57:20.497 cctalk:     463 > 04
12:57:20.497 cctalk: Timeout (90) for 217 to ccHopper @ 4
12:57:20.497 ccHopper@4: No response to message
12:57:20.497 Exec: cctalk task took 10 msec

12:57:20.545 ccHopper@4: Re-Identifying hopper

12:57:20.715 ccHopper@4: Hopper count 438 OK
12:57:20.715 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:57:20.715 Exec: cctalk task took 9 msec

12:57:25.583 455:30

12:58:25.370 455:31

12:58:49.217 cctalk:       0 < 00
12:58:49.217 cctalk:       3 > 04
12:58:49.217 cctalk:      13 < 00
12:58:49.217 cctalk:       3 > 04
12:58:49.217 cctalk: Timeout (90) for 166 to ccHopper @ 4
12:58:49.217 ccHopper@4: No response to message
12:58:49.217 Exec: cctalk task took 9 msec
12:58:49.217 ccHopper@4: Re-Identifying hopper

12:58:49.391 ccHopper@4: Hopper count 438 OK
12:58:49.391 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
12:58:49.391 Exec: cctalk task took 9 msec

12:59:25.161 455:32

11 August 2021     Firmware: 1.1.12.83 from Feb 16 2018 at 13:55:29     Driver:1.2.0.1
13:00:24.949 455:33

13:01:02.098 cctalk:       0 < 00
13:01:02.098 cctalk:       3 > 04
13:01:02.098 cctalk:      13 < 00
13:01:02.098 cctalk:       3 > 04
13:01:02.098 cctalk: Timeout (90) for 166 to ccHopper @ 4
13:01:02.098 ccHopper@4: No response to message
13:01:02.098 Exec: cctalk task took 9 msec
13:01:02.098 ccHopper@4: Re-Identifying hopper

13:01:02.273 ccHopper@4: Hopper count 438 OK
13:01:02.273 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
13:01:02.273 Exec: cctalk task took 10 msec

13:01:24.721 455:34

13:02:18.892 cctalk:       0 < 00
13:02:18.892 cctalk:       3 > 03
13:02:18.892 cctalk:      16 < 00
13:02:18.892 cctalk:     463 > 04
13:02:18.892 cctalk: Timeout (90) for 217 to ccHopper @ 4
13:02:18.892 ccHopper@4: No response to message
13:02:18.892 Exec: cctalk task took 9 msec

13:02:18.940 ccHopper@4: Re-Identifying hopper

13:02:19.112 ccHopper@4: Hopper count 438 OK
13:02:19.112 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
13:02:19.112 Exec: cctalk task took 10 msec

13:02:24.508 455:35

13:03:24.296 455:36

13:04:00.506 cctalk:       0 < 00
13:04:00.506 cctalk:       3 > 03
13:04:00.506 cctalk:      16 < 00
13:04:00.506 cctalk:     463 > 04
13:04:00.506 cctalk: Timeout (90) for 217 to ccHopper @ 4
13:04:00.507 ccHopper@4: No response to message
13:04:00.507 Exec: cctalk task took 9 msec

13:04:00.554 ccHopper@4: Re-Identifying hopper

13:04:00.727 ccHopper@4: Hopper count 438 OK
13:04:00.727 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
13:04:00.727 Exec: cctalk task took 9 msec

13:04:24.072 455:37

13:05:23.859 455:38

13:06:23.647 455:39

13:07:06.197 cctalk:       0 < 00
13:07:06.197 cctalk:       3 > 03
13:07:06.197 cctalk:      16 < 00
13:07:06.197 cctalk:     463 > 04
13:07:06.197 cctalk: Timeout (90) for 217 to ccHopper @ 4
13:07:06.197 ccHopper@4: No response to message
13:07:06.197 Exec: cctalk task took 9 msec

13:07:06.245 ccHopper@4: Re-Identifying hopper

13:07:06.416 ccHopper@4: Hopper count 438 OK
13:07:06.416 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
13:07:06.416 Exec: cctalk task took 9 msec

13:07:23.421 455:40

13:08:23.208 455:41

13:08:25.233 cctalk:       0 < 00
13:08:25.233 cctalk:       3 > 04
13:08:25.233 cctalk:      13 < 00
13:08:25.233 cctalk:       3 > 04
13:08:25.233 cctalk: Timeout (90) for 166 to ccHopper @ 4
13:08:25.233 ccHopper@4: No response to message
13:08:25.233 Exec: cctalk task took 9 msec
13:08:25.233 ccHopper@4: Re-Identifying hopper

13:08:25.407 ccHopper@4: Hopper count 438 OK
13:08:25.407 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
13:08:25.407 Exec: cctalk task took 9 msec

13:09:23.001 455:42

13:09:37.758 cctalk:       0 < 00
13:09:37.758 cctalk:       3 > 04
13:09:37.758 cctalk:      13 < 00
13:09:37.758 cctalk:       3 > 04
13:09:37.758 cctalk: Timeout (90) for 166 to ccHopper @ 4
13:09:37.758 ccHopper@4: No response to message
13:09:37.758 Exec: cctalk task took 9 msec
13:09:37.758 ccHopper@4: Re-Identifying hopper

13:09:37.931 ccHopper@4: Hopper count 438 OK
13:09:37.931 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
13:09:37.931 Exec: cctalk task took 9 msec

13:10:21.171 cctalk:       0 < 00
13:10:21.171 cctalk:       3 > 04
13:10:21.171 cctalk:      13 < 00
13:10:21.171 cctalk:       3 > 04
13:10:21.171 cctalk: Timeout (90) for 166 to ccHopper @ 4
13:10:21.171 ccHopper@4: No response to message
13:10:21.171 Exec: cctalk task took 9 msec
13:10:21.171 ccHopper@4: Re-Identifying hopper

13:10:21.344 ccHopper@4: Hopper count 438 OK
13:10:21.344 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
13:10:21.344 Exec: cctalk task took 9 msec

13:10:22.785 455:43

13:11:22.589 455:44

13:12:22.360 455:45

13:13:22.132 455:46

13:13:26.814 cctalk:       0 < 00
13:13:26.814 cctalk:       3 > 03
13:13:26.814 cctalk:      17 < 00
13:13:26.814 cctalk:     463 > 04
13:13:26.814 cctalk: Timeout (90) for 217 to ccHopper @ 4
13:13:26.814 ccHopper@4: No response to message
13:13:26.814 Exec: cctalk task took 9 msec

13:13:26.862 ccHopper@4: Re-Identifying hopper

13:13:27.036 ccHopper@4: Hopper count 438 OK
13:13:27.036 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
13:13:27.036 Exec: cctalk task took 10 msec

13:13:39.022 cctalk:       0 < 00
13:13:39.022 cctalk:       3 > 04
13:13:39.022 cctalk:      13 < 00
13:13:39.022 cctalk:       3 > 04
13:13:39.022 cctalk: Timeout (90) for 166 to ccHopper @ 4
13:13:39.022 ccHopper@4: No response to message
13:13:39.022 Exec: cctalk task took 9 msec
13:13:39.022 ccHopper@4: Re-Identifying hopper

13:13:39.192 ccHopper@4: Hopper count 438 OK
13:13:39.192 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
13:13:39.192 Exec: cctalk task took 9 msec

13:13:55.383 ccHopper@4: Selftest OK
13:13:55.383 DP: Event 000060 for Dispenser 2

13:13:55.954 ccHopper@3: Selftest OK
13:13:55.954 DP: Event 000060 for Dispenser 4

13:14:21.925 455:47

13:14:32.144 cctalk:       0 < 00
13:14:32.144 cctalk:       3 > 04
13:14:32.144 cctalk:      13 < 00
13:14:32.144 cctalk:       3 > 04
13:14:32.144 cctalk: Timeout (90) for 166 to ccHopper @ 4
13:14:32.144 ccHopper@4: No response to message
13:14:32.144 Exec: cctalk task took 9 msec
13:14:32.144 ccHopper@4: Re-Identifying hopper

13:14:32.317 ccHopper@4: Hopper count 438 OK
13:14:32.317 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
13:14:32.318 Exec: cctalk task took 9 msec

13:15:21.697 455:48

13:16:00.769 cctalk:       0 < 00
13:16:00.769 cctalk:       3 > 03
13:16:00.769 cctalk:      16 < 00
13:16:00.769 cctalk:     463 > 04
13:16:00.769 cctalk: Timeout (90) for 217 to ccHopper @ 4
13:16:00.769 ccHopper@4: No response to message
13:16:00.769 Exec: cctalk task took 9 msec

13:16:00.817 ccHopper@4: Re-Identifying hopper

13:16:00.988 ccHopper@4: Hopper count 438 OK
13:16:00.988 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
13:16:00.988 Exec: cctalk task took 9 msec

13:16:21.483 455:49

13:17:21.270 455:50

13:18:21.058 455:51

13:18:32.414 MDB: Selftest OK
13:18:32.414 DP: Event 0000e0 for Acceptor 0

13:19:20.833 455:52

13:20:20.620 455:53

13:20:51.039 cctalk:       0 < 00
13:20:51.039 cctalk:       3 > 04
13:20:51.039 cctalk:      13 < 00
13:20:51.039 cctalk:       3 > 04
13:20:51.039 cctalk: Timeout (90) for 166 to ccHopper @ 4
13:20:51.039 ccHopper@4: No response to message
13:20:51.040 Exec: cctalk task took 10 msec
13:20:51.040 ccHopper@4: Re-Identifying hopper

13:20:51.213 ccHopper@4: Hopper count 438 OK
13:20:51.213 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
13:20:51.213 Exec: cctalk task took 9 msec

13:20:59.981 cctalk:       0 < 00
13:20:59.981 cctalk:       3 > 04
13:20:59.981 cctalk:      13 < 00
13:20:59.981 cctalk:       3 > 04
13:20:59.981 cctalk: Timeout (90) for 166 to ccHopper @ 4
13:20:59.981 ccHopper@4: No response to message
13:20:59.981 Exec: cctalk task took 9 msec
13:20:59.981 ccHopper@4: Re-Identifying hopper

13:21:00.136 ccHopper@4: Hopper count 438 OK
13:21:00.136 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
13:21:00.136 Exec: cctalk task took 9 msec

13:21:20.407 455:54

13:22:20.194 455:55

13:23:04.215 cctalk:       0 < 00
13:23:04.215 cctalk:       3 > 04
13:23:04.215 cctalk:      14 < 00
13:23:04.215 cctalk:       3 > 04
13:23:04.215 cctalk: Timeout (90) for 166 to ccHopper @ 4
13:23:04.215 ccHopper@4: No response to message
13:23:04.215 Exec: cctalk task took 9 msec
13:23:04.215 ccHopper@4: Re-Identifying hopper

13:23:04.389 ccHopper@4: Hopper count 438 OK
13:23:04.389 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
13:23:04.389 Exec: cctalk task took 9 msec

13:23:19.984 455:56

13:24:12.414 cctalk:       0 < 00
13:24:12.414 cctalk:       3 > 04
13:24:12.415 cctalk:      13 < 00
13:24:12.415 cctalk:       3 > 04
13:24:12.415 cctalk: Timeout (90) for 166 to ccHopper @ 4
13:24:12.415 ccHopper@4: No response to message
13:24:12.415 Exec: cctalk task took 9 msec
13:24:12.415 ccHopper@4: Re-Identifying hopper

13:24:12.586 ccHopper@4: Hopper count 438 OK
13:24:12.586 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
13:24:12.586 Exec: cctalk task took 9 msec

13:24:19.759 455:57

13:25:19.547 455:58

13:26:19.319 455:59

13:27:19.107 456:00

13:28:11.971 cctalk:       0 < 00
13:28:11.971 cctalk:       3 > 04
13:28:11.971 cctalk:      13 < 00
13:28:11.971 cctalk:       3 > 04
13:28:11.971 cctalk: Timeout (90) for 166 to ccHopper @ 4
13:28:11.971 ccHopper@4: No response to message
13:28:11.971 Exec: cctalk task took 9 msec
13:28:11.972 ccHopper@4: Re-Identifying hopper

13:28:12.142 ccHopper@4: Hopper count 438 OK
13:28:12.143 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
13:28:12.143 Exec: cctalk task took 9 msec

13:28:18.915 456:01

13:29:18.687 456:02

13:30:18.459 456:03

13:31:18.246 456:04

13:32:18.018 456:05

13:32:35.224 cctalk:       0 < 00
13:32:35.224 cctalk:       3 > 03
13:32:35.224 cctalk:      16 < 00
13:32:35.224 cctalk:     463 > 04
13:32:35.224 cctalk: Timeout (90) for 217 to ccHopper @ 4
13:32:35.224 ccHopper@4: No response to message
13:32:35.224 Exec: cctalk task took 9 msec

13:32:35.272 ccHopper@4: Re-Identifying hopper

13:32:35.444 ccHopper@4: Hopper count 438 OK
13:32:35.444 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
13:32:35.444 Exec: cctalk task took 10 msec

13:33:17.811 456:06

13:34:08.266 cctalk:       0 < 00
13:34:08.266 cctalk:       3 > 04
13:34:08.266 cctalk:      13 < 00
13:34:08.266 cctalk:       3 > 04
13:34:08.266 cctalk: Timeout (90) for 166 to ccHopper @ 4
13:34:08.266 ccHopper@4: No response to message
13:34:08.266 Exec: cctalk task took 9 msec
13:34:08.266 ccHopper@4: Re-Identifying hopper

13:34:08.441 ccHopper@4: Hopper count 438 OK
13:34:08.441 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
13:34:08.441 Exec: cctalk task took 10 msec

13:34:17.584 456:07

13:35:17.371 456:08

13:36:17.159 456:09

13:37:16.931 456:10

13:38:16.719 456:11

13:39:16.507 456:12

13:39:27.593 cctalk:       0 < 00
13:39:27.593 cctalk:       3 > 04
13:39:27.593 cctalk:      13 < 00
13:39:27.593 cctalk:       3 > 04
13:39:27.593 cctalk: Timeout (90) for 166 to ccHopper @ 4
13:39:27.593 ccHopper@4: No response to message
13:39:27.593 Exec: cctalk task took 9 msec
13:39:27.593 ccHopper@4: Re-Identifying hopper

13:39:27.764 ccHopper@4: Hopper count 438 OK
13:39:27.764 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
13:39:27.764 Exec: cctalk task took 9 msec

13:39:49.453 cctalk:       0 < 00
13:39:49.453 cctalk:       3 > 04
13:39:49.453 cctalk:      13 < 00
13:39:49.453 cctalk:       3 > 04
13:39:49.453 cctalk: Timeout (90) for 166 to ccHopper @ 4
13:39:49.453 ccHopper@4: No response to message
13:39:49.453 Exec: cctalk task took 9 msec
13:39:49.453 ccHopper@4: Re-Identifying hopper

13:39:49.623 ccHopper@4: Hopper count 438 OK
13:39:49.623 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
13:39:49.623 Exec: cctalk task took 9 msec

13:40:00.529 cctalk:       0 < 00
13:40:00.529 cctalk:       3 > 04
13:40:00.529 cctalk:      13 < 00
13:40:00.529 cctalk:       3 > 04
13:40:00.529 cctalk: Timeout (90) for 166 to ccHopper @ 4
13:40:00.529 ccHopper@4: No response to message
13:40:00.529 Exec: cctalk task took 9 msec
13:40:00.529 ccHopper@4: Re-Identifying hopper

13:40:00.705 ccHopper@4: Hopper count 438 OK
13:40:00.705 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
13:40:00.705 Exec: cctalk task took 9 msec

13:40:16.284 456:13

13:41:16.072 456:14

13:42:15.844 456:15

13:43:15.632 456:16

13:43:19.063 ccHopper@4: Selftest OK
13:43:19.064 DP: Event 000060 for Dispenser 2

13:43:19.634 ccHopper@3: Selftest OK
13:43:19.634 DP: Event 000060 for Dispenser 4

13:43:54.738 cctalk:       0 < 00
13:43:54.738 cctalk:       3 > 04
13:43:54.738 cctalk:      13 < 00
13:43:54.738 cctalk:       3 > 04
13:43:54.738 cctalk: Timeout (90) for 166 to ccHopper @ 4
13:43:54.738 ccHopper@4: No response to message
13:43:54.738 Exec: cctalk task took 9 msec
13:43:54.738 ccHopper@4: Re-Identifying hopper

13:43:54.914 ccHopper@4: Hopper count 438 OK
13:43:54.914 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
13:43:54.914 Exec: cctalk task took 10 msec

13:44:15.409 456:17

13:45:15.197 456:18

13:46:14.984 456:19

13:46:19.147 MDB: Selftest OK
13:46:19.147 DP: Event 0000e0 for Acceptor 0

13:47:14.756 456:20

13:47:36.137 MDB: Enable
13:47:36.137 DP: MDB Status to 0
13:47:36.137 MDB: inhibits to 001f

13:48:02.290 MDB: Disable
13:48:02.290 DP: MDB Status to 4
13:48:02.290 MDB: Inhibit all coins

13:48:05.073 cctalk:       0 < 00
13:48:05.073 cctalk:       3 > 03
13:48:05.073 cctalk:      16 < 00
13:48:05.073 cctalk:     463 > 04
13:48:05.074 cctalk: Timeout (90) for 217 to ccHopper @ 4
13:48:05.074 ccHopper@4: No response to message
13:48:05.074 Exec: cctalk task took 9 msec

13:48:05.121 ccHopper@4: Re-Identifying hopper

13:48:05.296 ccHopper@4: Hopper count 438 OK
13:48:05.296 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
13:48:05.296 Exec: cctalk task took 9 msec

13:48:14.550 456:21

13:48:19.617 DP: Pay request for 100, (394480 - 394380 (4133181775 - 4132787295))

13:48:20.136 DP: Pay 100 (10 @ 10) from Level 3 Payout System @ 8
13:48:20.136 MDB Payout@8: Pay 10 units
13:48:20.136 MDB: Enable
13:48:20.136 DP: MDB Status to 0
13:48:20.136 MDB: inhibits to 001f

13:48:21.237 MDB Payout@8: 10 units
13:48:21.237 DP: 100 paid so far.
13:48:21.237 MDB Payout@8: Paid 1 @ 100, Total 10 units, 0 not paid

13:48:21.271 DP: Cycle End
, 10 coins @ 10 status: 1

13:48:21.411 DP:   Finished - overall status: 1, paid now 394480
13:48:21.411 Exec: DP task took 174 msec

13:48:21.542 MDB: Disable
13:48:21.542 DP: MDB Status to 4
13:48:21.542 MDB: Inhibit all coins

13:48:21.613 DP: Pay request for 50, (394530 - 394480 (4133181825 - 4132787295))

13:48:22.133 DP: Pay 50 (5 @ 10) from Level 3 Payout System @ 8
13:48:22.133 MDB Payout@8: Pay 5 units
13:48:22.133 MDB: Enable
13:48:22.133 DP: MDB Status to 0
13:48:22.133 MDB: inhibits to 001f

13:48:22.947 MDB Payout@8: 5 units
13:48:22.947 DP: 50 paid so far.
13:48:22.947 MDB Payout@8: Paid 1 @ 50, Total 5 units, 0 not paid

13:48:23.014 DP: Cycle End
, 5 coins @ 10 status: 1

13:48:23.147 DP:   Finished - overall status: 1, paid now 394530
13:48:23.147 Exec: DP task took 204 msec

13:48:23.278 MDB: Disable
13:48:23.278 DP: MDB Status to 4
13:48:23.278 MDB: Inhibit all coins

13:48:23.348 DP: Pay request for 40, (394570 - 394530 (4133181865 - 4132787295))

13:48:23.868 DP: Pay 40 (4 @ 10) from Level 3 Payout System @ 8
13:48:23.868 MDB Payout@8: Pay 4 units
13:48:23.868 MDB: Enable
13:48:23.868 DP: MDB Status to 0
13:48:23.868 MDB: inhibits to 001f

13:48:24.561 MDB Payout@8: 2 units
13:48:24.561 DP: 20 paid so far.

13:48:25.265 MDB Payout@8: 2 units
13:48:25.265 DP: 40 paid so far.
13:48:25.265 MDB Payout@8: Paid 2 @ 20, Total 4 units, 0 not paid

13:48:25.299 DP: Cycle End
, 4 coins @ 10 status: 1

13:48:25.437 DP:   Finished - overall status: 1, paid now 394570
13:48:25.437 Exec: DP task took 173 msec

13:48:25.571 MDB: Disable
13:48:25.571 DP: MDB Status to 4
13:48:25.571 MDB: Inhibit all coins

13:49:14.455 456:22

13:50:14.243 456:23

13:50:17.064 MDB: Enable
13:50:17.064 DP: MDB Status to 0

13:50:17.096 MDB: inhibits to 001f

13:50:18.415 MDB: Disable
13:50:18.415 DP: MDB Status to 4
13:50:18.415 MDB: Inhibit all coins

13:50:35.005 DP: Switch 0: open 21, close 21

13:51:14.025 456:24

13:51:23.311 DP: Switch 0: open 21, close 22

13:51:26.218 MDB: Enable
13:51:26.218 DP: MDB Status to 0
13:51:26.218 MDB: inhibits to 001f

13:51:27.654 MDB: Disable
13:51:27.654 DP: MDB Status to 4
13:51:27.654 MDB: Inhibit all coins

13:52:13.800 456:25

13:53:00.216 cctalk:       0 < 00
13:53:00.216 cctalk:       3 > 04
13:53:00.216 cctalk:      13 < 00
13:53:00.216 cctalk:       3 > 04
13:53:00.216 cctalk: Timeout (90) for 166 to ccHopper @ 4
13:53:00.216 ccHopper@4: No response to message
13:53:00.216 Exec: cctalk task took 9 msec
13:53:00.216 ccHopper@4: Re-Identifying hopper

13:53:00.389 ccHopper@4: Hopper count 438 OK
13:53:00.389 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
13:53:00.390 Exec: cctalk task took 9 msec

13:53:13.583 456:26

13:53:23.161 cctalk:       0 < 00
13:53:23.161 cctalk:       3 > 04
13:53:23.161 cctalk:      14 < 00
13:53:23.161 cctalk:       3 > 04
13:53:23.161 cctalk: Timeout (90) for 166 to ccHopper @ 4
13:53:23.161 ccHopper@4: No response to message
13:53:23.161 Exec: cctalk task took 9 msec
13:53:23.161 ccHopper@4: Re-Identifying hopper

13:53:23.334 ccHopper@4: Hopper count 438 OK
13:53:23.334 DP: SUH1 Hopper S/N 162868, Address 4, Value 100 at dcc  updated
13:53:23.334 Exec: cctalk task took 9 msec

13:53:45.648 MDB: Enable
13:53:45.648 DP: MDB Status to 0
13:53:45.648 MDB: inhibits to 001f

13:53:57.263 MDB: Disable
13:53:57.263 DP: MDB Status to 4
13:53:57.263 MDB: Inhibit all coins

13:54:02.218 DP: Pay request for 1800, (396370 - 394570 (4133183665 - 4132787295))

13:54:02.737 DP: Pay 1800 (180 @ 10) from Level 3 Payout System @ 8
13:54:02.737 MDB Payout@8: Pay 180 units
13:54:02.737 MDB: Enable
13:54:02.737 DP: MDB Status to 0
13:54:02.737 MDB: inhibits to 001f

13:54:03.429 MDB Payout@8: 20 units
13:54:03.429 DP: 200 paid so far.

13:54:03.916 MDB Payout@8: 20 units
13:54:03.916 DP: 400 paid so far.

13:54:04.498 MDB Payout@8: 20 units
13:54:04.498 DP: 600 paid so far.

13:54:04.985 MDB Payout@8: 20 units
13:54:04.985 DP: 800 paid so far.

13:54:05.470 MDB Payout@8: 20 units
13:54:05.470 DP: 1000 paid so far.

13:54:05.955 MDB Payout@8: 20 units
13:54:05.955 DP: 1200 paid so far.

13:54:06.441 MDB Payout@8: 20 units
13:54:06.441 DP: 1400 paid so far.

13:54:06.927 MDB Payout@8: 20 units
13:54:06.927 DP: 1600 paid so far.

13:54:07.640 MDB Payout@8: 20 units
13:54:07.640 MDB Payout@8: 20 units
13:54:07.640 DP: 2000 paid so far.
13:54:07.641 MDB Payout@8: Paid 9 @ 200, Total 180 units, 0 not paid

13:54:07.708 DP: 1800 paid so far.
13:54:07.708 DP: Cycle End
, 180 coins @ 10 status: 1
13:54:07.847 DP:   Finished - overall status: 1, paid now 396370
13:54:07.847 Exec: DP task took 206 msec
13:54:07.847 MDB: Disable

13:54:07.884 DP: MDB Status to 4
13:54:07.884 Exec: DP task took 25 msec
13:54:07.884 MDB: Inhibit all coins

davebush · Post by **davebush** » Tue Aug 17, 2021 2:02 pm

Hi,

This appears to be defect / problem with the MDB protocol and a small amount of noise on the line. The releveant MDB message is "how much have you paid since last time" and paylink reacts to a non zero answer by incrementing the ongoing payout and outputting the line:
MDB Payout@8: 20 units

As you can see, at 13:54:07.640 this line was output twice, indicating that two non zero messages were processed in quick succession. This implies to me that the handshake with the changer broke down in a way that Paylink couldn't detect and the changer effectively sent the same "event" twice.

As a general policy with Paylink the changes in total paid that occur during a payout should only be used for inicidental monitoring - any actions that relate to money received by a customer should be left until the payout terminates. With the MDB system, a completely different message is returned by the changer at the payout end, which acurately describes the entire payout. This is not subject to the same "retry" problems as the message covers the entire payout and so even if it is repeated there is no confusion. This message is what resulted in the final:
MDB Payout@8: Paid 9 @ 200, Total 180 units, 0 not paid

Regards

Dave

aurelien · Post by **aurelien** » Thu Aug 19, 2021 12:56 pm

I am ok with the point to check the lastPayStatus() , and if it reach PAY_FINISHED to check CurrentPaid() to have the final refund done.

But during the refund I am using CurrentPaid() for calculate the total amount refund done. So when CurrentPaid() show me a refund of 4€ and in fact it's 2€ it's a problem for my software.

Into your Application Program interface manuel (Currentpaid page 20) it's write

Remarks 1. The value that is returned by this function is updated in real time, as the money handling equipment succeeds in dispensing coins.

2. The value that is returned by this call is never reset, but increments for the life of the interface card. It is the responsibility of the application to keep track of starting values and to monitor for new coin / note successful payments by increases in the returned value

You are doing exacly the same way on your software PayOut.c

Code: Select all

	CurrentPayOut = CurrentPaid() ;
        printf("Value paid to date: %ld\n", CurrentPayOut) ;

        EnableInterface() ;

        PayOut(NoOfCoins * 100) ;

        while (LastPayStatus() == PAY_ONGOING)
        {  
	    if (CurrentPayOut != CurrentPaid())
            {   CurrentPayOut = CurrentPaid() ;
                printf("      Now paid out: %ld\n", CurrentPayOut) ;
            }
            Sleep(10) ;
        }

        if (LastPayStatus() != PAY_FINISHED)
        {   printf("Error %d when paying %ld coins\n", LastPayStatus(), NoOfCoins) ;
            printf("        Total value paid out: %ld\n", CurrentPaid()) ;
        }else
            printf("%ld coins paid out, Value %ld\n", NoOfCoins, CurrentPaid()) ;

So you will write to the final client the line Now Paid out : 400

As it write in the manual CurrentPaid() give result in real time of money handling equipment succeeds in dispensing coin .

How can we manage it in real time to update the new amount to refund done and showing it to the customer ?

best regards

davebush · Post by **davebush** » Thu Aug 19, 2021 1:38 pm

Hi,

I understand your frustration. You should be able to write your software according to the API.

The underlying problem is that there was a fault in communication with the Changer. All the API description is based around the idea that there are never any faults. When recovering from faults things become more fluid.

I assume that this fault was a one off, and that it has never recurred. If it does recur, and especially if you can cause it to happen in a lab, then I can investigate further to see if something in the Paylink driver code is triggering the error.

If it is a one off, then you should not need to update your software, except the change you've already done to wait for PAY_FINISHED - there will always be problems if the underlying hardware fails.

Regards

Dave

aurelien · Post by **aurelien** » Fri Aug 20, 2021 2:18 pm

So If I understood correctly it's impossible to have a good accounting. The CF7900 have a coin +- with the sonar.
And the CurrentPaid() can't be used to check which coin was refund( as we can see)

The point is my client don't want error into the accounting.
So at the moment accounting may have error.

Other things.

We are using hopper and CF7900.
hopper cctalk 1€ (400coins)
hopper cctalk 0,50€ (400coins)
CF7900 2€ 1€ 0,50€ 0,20€ 0,10€ (each tubes have 20 coins execpt 1€ and 0,50 which have 5 coins)

If I send a payout of 18,70€ the paylink will first refund with hopper 1€ so 18 coins and then used CF7900. Why paylink is not using the 2€ from CF7900( those coin are recycling)?

other exemple hopper cctalk 1€ (empty) In this exemple If I send a payout of 18,70€ the paylink will first refund with hopper 0,50€, (37 coins ..)
My client want to used first CF7900 and then Hopper.

Do you have a document that describe how are used hopper and CF7900 when we calling Payout( ) ?

davebush · Post by **davebush** » Fri Aug 20, 2021 7:05 pm

Hi,

So far as accounting goes, at the time that PAY_FINISHED is returned the figures are accurate, and at the point the change in the number of different coins is also accurate. (Until PAY_FINISHED the CF7900 does not tell Paylink which coins have been chosen.)

Using the CF7900 in the way you describe is made difficult because of the way the MDB protocol operates, the fact that Paylink will leave the lowest value to last and that a CF7900 in level 3 mode is treated as only having .10€ coins.

I imagine that the actual alogrithm you want is something like pay 2€, 1€ and 0,50€ coins from the CF7900 until those tubes are emply,
then switch to the hoppers,
then pay whatever amount is left from the 0,20€ 0,10€ on the CF7900.

There is no way you can guarantee that, but you can get close by an algorithm such as:

Normally Inhibit both hoppers (set Inhibit in DispenserBlock for both)

Before a payout, subtract the total value in the 2€ 1€ and 0,50€ coins in the CF7900 from the amount to pay.
If the result is positive, then:

Inhibit the CF7900
clear the inihibt on the hoppers
run a payout for this positive difference
subtract the amount actually paid out ftom the amount to pay (remember that the hoppers may have run empty)
Clear the Inhibit on the CF7900
Replace inihibt on the hoppers

Finally run a payout for the (residual) amount from the CF7900 (this may pay a large number of low value coins as they are all that is left)

Aardvark Embedded Solutions Ltd Support Forum

Paylink -> CF7900 MDB

Paylink -> CF7900 MDB

Re: Paylink -> CF7900 MDB

Re: Paylink -> CF7900 MDB

Re: Paylink -> CF7900 MDB

Re: Paylink -> CF7900 MDB

Re: Paylink -> CF7900 MDB

Re: Paylink -> CF7900 MDB

Re: Paylink -> CF7900 MDB

Re: Paylink -> CF7900 MDB

Re: Paylink -> CF7900 MDB