[T] render:page.go:267 processing sink idx=2, value=3: FATIN 1.89, netremaining=90, l=44 [T] render:page.go:267 processing sink idx=3, value=4: NEMA 17.41, netremaining=90, l=58 [T] render:page.go:267 processing sink idx=4, value=5: MNAZI 0.01, netremaining=90, l=72 [T] render:page.go:267 processing sink idx=5, value=6: CALIFO 250.71, netremaining=90, l=89 [T] render:page.go:267 processing sink idx=6, value=7: NYUMBU 9.32, netremaining=90, l=104 [D] render:size.go:87 Added cursor offset=91 [T] render:page.go:267 processing sink idx=7, value=8: MASKA 0.30, netremaining=82, l=27 [T] render:page.go:267 processing sink idx=8, value=9: YSP 0.15, netremaining=82, l=39 [T] render:page.go:267 processing sink idx=9, value=10: GRTV 90.35, netremaining=82, l=54 [T] render:page.go:267 processing sink idx=10, value=11: JANET 2.00, netremaining=82, l=69 [T] render:page.go:267 processing sink idx=11, value=12: WADA 15.27, netremaining=82, l=84 [D] render:size.go:87 Added cursor offset=162 [T] render:page.go:267 processing sink idx=12, value=13: NGOSUB 0.00, netremaining=82, l=29 [T] render:page.go:267 processing sink idx=13, value=14: RIBA 0.00, netremaining=82, l=43 [T] render:page.go:267 processing sink idx=14, value=15: SIRI 0.68, netremaining=82, l=57 [T] render:page.go:267 processing sink idx=15, value=16: MISYO 48.41, netremaining=82, l=73 [T] render:page.go:267 processing sink idx=16, value=17: FHE 321.34, netremaining=82, l=88 [D] render:size.go:87 Added cursor offset=237 [T] render:page.go:267 processing sink idx=17, value=18: KHAIRA 0.00, netremaining=82, l=29 [T] render:page.go:267 processing sink idx=18, value=19: TWKL 140.98, netremaining=82, l=45 [T] render:page.go:267 processing sink idx=19, value=20: cUSD 0.50, netremaining=82, l=59 [T] render:page.go:267 processing sink idx=20, value=21: AMUA 98.55, netremaining=82, l=74 [T] render:page.go:267 processing sink idx=21, value=22: SRF 1.36, netremaining=82, l=87 [D] render:size.go:87 Added cursor offset=313 [T] render:page.go:267 processing sink idx=22, value=23: SOHAIL 0.09, netremaining=82, l=27 [T] render:page.go:267 processing sink idx=23, value=24: MOSEYO 8.24, netremaining=82, l=43 [T] render:page.go:267 processing sink idx=24, value=25: VDPA 815.30, netremaining=82, l=59 [T] render:page.go:267 processing sink idx=25, value=26: CARL 7.00, netremaining=82, l=73 [T] render:page.go:267 processing sink idx=26, value=27: LOLA 1019.78, netremaining=82, l=90 [D] render:size.go:87 Added cursor offset=388 [T] render:page.go:377 nosinkvalue idx=0, value=1: FSPTST 7.082: MEKO 10000.003: FATIN 1.894: NEMA 17.415: MNAZI 0.016: CALIFO 250.71 [T] render:page.go:377 nosinkvalue idx=1, value=7: NYUMBU 9.328: MASKA 0.309: YSP 0.1510: GRTV 90.3511: JANET 2.00 [T] render:page.go:377 nosinkvalue idx=2, value=12: WADA 15.2713: NGOSUB 0.0014: RIBA 0.0015: SIRI 0.6816: MISYO 48.41 [T] render:page.go:377 nosinkvalue idx=3, value=17: FHE 321.3418: KHAIRA 0.0019: TWKL 140.9820: cUSD 0.5021: AMUA 98.55 [T] render:page.go:377 nosinkvalue idx=4, value=22: SRF 1.3623: SOHAIL 0.0924: MOSEYO 8.2425: VDPA 815.3026: CARL 7.00 [T] render:page.go:377 nosinkvalue idx=5, value=27: LOLA 1019.78 [T] db:db.go:275 language using ln=eng (English) [T] db:db.go:280 made db lookup key lk=0473656c6563745f766f7563686572, pfx=4 [T] fsdb:fs.go:116 trying fs get i=0, key=73656c6563745f766f7563686572, path=/var/www/golang/sarafu-vise/services/registration/4select_voucher_eng [T] fsdb:fs.go:116 trying fs get i=1, key=73656c6563745f766f7563686572, path=/var/www/golang/sarafu-vise/services/registration/select_voucher_eng [T] fsdb:fs.go:116 trying fs get i=2, key=73656c6563745f766f7563686572, path=/var/www/golang/sarafu-vise/services/registration/4select_voucher [T] fsdb:fs.go:116 trying fs get i=3, key=73656c6563745f766f7563686572, path=/var/www/golang/sarafu-vise/services/registration/select_voucher [T] render:size.go:100 check values k=get_vouchers, v=1: FSPTST 7.082: MEKO 10000.003: FATIN 1.894: NEMA 17.415: MNAZI 0.016: CALIFO 250.71 7: NYUMBU 9.328: MASKA 0.309: YSP 0.1510: GRTV 90.3511: JANET 2.00 12: WADA 15.2713: NGOSUB 0.0014: RIBA 0.0015: SIRI 0.6816: MISYO 48.41 17: FHE 321.3418: KHAIRA 0.0019: TWKL 140.9820: cUSD 0.5021: AMUA 98.55 22: SRF 1.3623: SOHAIL 0.0924: MOSEYO 8.2425: VDPA 815.3026: CARL 7.00 27: LOLA 1019.78, idx=0, cursors=[0 91 162 237 313 388] [D] render:page.go:175 render for index=0 [D] render:page.go:391 rendered template bytes=134 [D] render:menu.go:261 applypage m=pagecount: 6 menusink: false next: true prev: false, idx=0 [T] db:db.go:275 language using ln=eng (English) [T] db:db.go:280 made db lookup key lk=026261636b5f6d656e75, pfx=2 [T] fsdb:fs.go:116 trying fs get i=0, key=6261636b5f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2back_menu_eng [T] fsdb:fs.go:116 trying fs get i=1, key=6261636b5f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/back_menu_eng [T] fsdb:fs.go:116 trying fs get i=2, key=6261636b5f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2back_menu [T] fsdb:fs.go:116 trying fs get i=3, key=6261636b5f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/back_menu [T] db:db.go:275 language using ln=eng (English) [T] db:db.go:280 made db lookup key lk=02717569745f6d656e75, pfx=2 [T] fsdb:fs.go:116 trying fs get i=0, key=717569745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2quit_menu_eng [T] fsdb:fs.go:116 trying fs get i=1, key=717569745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/quit_menu_eng [T] fsdb:fs.go:116 trying fs get i=2, key=717569745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2quit_menu [T] fsdb:fs.go:116 trying fs get i=3, key=717569745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/quit_menu [T] db:db.go:275 language using ln=eng (English) [T] db:db.go:280 made db lookup key lk=026e6578745f6d656e75, pfx=2 [T] fsdb:fs.go:116 trying fs get i=0, key=6e6578745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2next_menu_eng [T] fsdb:fs.go:116 trying fs get i=1, key=6e6578745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/next_menu_eng [T] fsdb:fs.go:116 trying fs get i=2, key=6e6578745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2next_menu [T] fsdb:fs.go:116 trying fs get i=3, key=6e6578745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/next_menu [D] render:page.go:400 rendered menu bytes=25 [I] persist:persist.go:100 saving state and cache self=persister @0xc0004fe600 state:0xc000122500 cache:0xc0004fe2c0, key=+254700000000, state=state @0xc000122500 moves: 51 idx: 0 flags: 0x0653100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [T] persist:persist.go:101 saving bytecode code=0008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [T] db:db.go:280 made db lookup key lk=102b323534373030303030303030, pfx=16 [T] postgresdb:pg.go:98 begin single tx err= [T] postgresdb:pg.go:154 put key=2b323534373030303030303030, val=a2655374617465a764436f646558560008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a6845786563506174688464726f6f74646d61696e6b6d795f766f7563686572736e73656c6563745f766f75636865726742697453697a6518886753697a654964780065466c616773510653100000000000000000000000000000654d6f7665731833684c616e6775616765a264436f646563656e67644e616d6567456e676c697368664d656d6f7279a569436163686553697a65006c436163686555736553697a651901aa65436163686585a0a374636865636b5f626c6f636b65645f7374617475736075636865636b5f6163636f756e745f637265617465646074636865636b5f6163636f756e745f73746174757360a375636c6561725f74656d706f726172795f76616c7565606f6d616e6167655f766f756368657273606d636865636b5f62616c616e63657642616c616e63653a203235392e3331205649445a4f0aa1781872657365745f6163636f756e745f617574686f72697a656460a16c6765745f766f756368657273790194313a2046535054535420372e30380a323a204d454b4f2031303030302e30300a333a20464154494e20312e38390a343a204e454d412031372e34310a353a204d4e415a4920302e30310a363a2043414c49464f203235302e37310a373a204e59554d425520392e33320a383a204d41534b4120302e33300a393a2059535020302e31350a31303a20475254562039302e33350a31313a204a414e455420322e30300a31323a20574144412031352e32370a31333a204e474f53554220302e30300a31343a205249424120302e30300a31353a205349524920302e36380a31363a204d4953594f2034382e34310a31373a20464845203332312e33340a31383a204b484149524120302e30300a31393a2054574b4c203134302e39380a32303a206355534420302e35300a32313a20414d55412039382e35350a32323a2053524620312e33360a32333a20534f4841494c20302e30390a32343a204d4f5345594f20382e32340a32353a2056445041203831352e33300a32363a204341524c20372e30300a32373a204c4f4c4120313031392e37386553697a6573ad74636865636b5f626c6f636b65645f7374617475730175636865636b5f6163636f756e745f6372656174656402781872657365745f6163636f756e745f617574686f72697a65641074636865636b5f6163636f756e745f737461747573006d636865636b5f62616c616e63651880717665726966795f6372656174655f70696e0872736176655f74656d706f726172795f70696e066471756974006f6d616e6167655f766f75636865727318a06c6765745f766f756368657273006c7365745f6c616e67756167650675636c6561725f74656d706f726172795f76616c7565026e6372656174655f6163636f756e7400694c61737456616c7565790194313a2046535054535420372e30380a323a204d454b4f2031303030302e30300a333a20464154494e20312e38390a343a204e454d412031372e34310a353a204d4e415a4920302e30310a363a2043414c49464f203235302e37310a373a204e59554d425520392e33320a383a204d41534b4120302e33300a393a2059535020302e31350a31303a20475254562039302e33350a31313a204a414e455420322e30300a31323a20574144412031352e32370a31333a204e474f53554220302e30300a31343a205249424120302e30300a31353a205349524920302e36380a31363a204d4953594f2034382e34310a31373a20464845203332312e33340a31383a204b484149524120302e30300a31393a2054574b4c203134302e39380a32303a206355534420302e35300a32313a20414d55412039382e35350a32323a2053524620312e33360a32333a20534f4841494c20302e30390a32343a204d4f5345594f20382e32340a32353a2056445041203831352e33300a32363a204341524c20372e30300a32373a204c4f4c4120313031392e3738 [T] postgresdb:pg.go:118 stop single tx err= [T] persist:persist.go:107 state and cache flushed from persister [T] engine:db.go:389 that's a wrap engine=&{0xc000122500 0xc0004fe2c0 0xc000001c20 0xc00011f5e0 0xc0004fe600 {160 +254700000000 root 128 0 false false : true false} 0xa86080 true false true 0} [T] postgresdb:pg.go:128 stop multi tx err= [D] atserver:parse.go:48 Received request: {"body":"phoneNumber=%2B254700000000\u0026text=88\u0026="}=?? [I] visedriver.request:base.go:68 new request data={context.Background.WithValue(net/http context value http-server, *http.Server).WithValue(net/http context value local-addr, 127.0.0.1:7123).WithCancel.WithCancel sessionid '+254700000000', rootpath 'root', flagcount 128, language '' [56 56] 0xc0005a80e0 false} [T] postgresdb:pg.go:98 begin single tx err= [D] engine:db.go:214 ca ca=&{0 0 [map[]] map[check_account_created:2 check_account_status:0 check_balance:128 check_blocked_status:1 clear_temporary_value:2 create_account:0 get_vouchers:0 manage_vouchers:160 quit:0 reset_account_authorized:16 save_temporary_pin:6 set_language:6 verify_create_pin:8] 1: FSPTST 7.08 2: MEKO 10000.00 3: FATIN 1.89 4: NEMA 17.41 5: MNAZI 0.01 6: CALIFO 250.71 7: NYUMBU 9.32 8: MASKA 0.30 9: YSP 0.15 10: GRTV 90.35 11: JANET 2.00 12: WADA 15.27 13: NGOSUB 0.00 14: RIBA 0.00 15: SIRI 0.68 16: MISYO 48.41 17: FHE 321.34 18: KHAIRA 0.00 19: TWKL 140.98 20: cUSD 0.50 21: AMUA 98.55 22: SRF 1.36 23: SOHAIL 0.09 24: MOSEYO 8.24 25: VDPA 815.30 26: CARL 7.00 27: LOLA 1019.78 false} [T] db:db.go:280 made db lookup key lk=102b323534373030303030303030, pfx=16 [T] postgresdb:pg.go:98 begin single tx err= [T] postgresdb:pg.go:181 get key=2b323534373030303030303030 [T] postgresdb:pg.go:118 stop single tx err= [I] persist:persist.go:126 loaded state and cache self=persister @0xc0004fe600 state:0xc000453500 cache:0xc0004fe2c0, key=+254700000000, state=state @0xc000453500 moves: 51 idx: 0 flags: 0x0653100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [T] persist:persist.go:127 loaded bytecode code=0008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [T] engine:db.go:264 set persister st=state @0xc000453500 moves: 51 idx: 0 flags: 0x0653100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English), cac=&{0 426 [map[] map[check_account_created: check_account_status: check_blocked_status:] map[check_balance:Balance: 259.31 VIDZO clear_temporary_value: manage_vouchers:] map[reset_account_authorized:] map[get_vouchers:1: FSPTST 7.08 2: MEKO 10000.00 3: FATIN 1.89 4: NEMA 17.41 5: MNAZI 0.01 6: CALIFO 250.71 7: NYUMBU 9.32 8: MASKA 0.30 9: YSP 0.15 10: GRTV 90.35 11: JANET 2.00 12: WADA 15.27 13: NGOSUB 0.00 14: RIBA 0.00 15: SIRI 0.68 16: MISYO 48.41 17: FHE 321.34 18: KHAIRA 0.00 19: TWKL 140.98 20: cUSD 0.50 21: AMUA 98.55 22: SRF 1.36 23: SOHAIL 0.09 24: MOSEYO 8.24 25: VDPA 815.30 26: CARL 7.00 27: LOLA 1019.78]] map[check_account_created:2 check_account_status:0 check_balance:128 check_blocked_status:1 clear_temporary_value:2 create_account:0 get_vouchers:0 manage_vouchers:160 quit:0 reset_account_authorized:16 save_temporary_pin:6 set_language:6 verify_create_pin:8] 1: FSPTST 7.08 2: MEKO 10000.00 3: FATIN 1.89 4: NEMA 17.41 5: MNAZI 0.01 6: CALIFO 250.71 7: NYUMBU 9.32 8: MASKA 0.30 9: YSP 0.15 10: GRTV 90.35 11: JANET 2.00 12: WADA 15.27 13: NGOSUB 0.00 14: RIBA 0.00 15: SIRI 0.68 16: MISYO 48.41 17: FHE 321.34 18: KHAIRA 0.00 19: TWKL 140.98 20: cUSD 0.50 21: AMUA 98.55 22: SRF 1.36 23: SOHAIL 0.09 24: MOSEYO 8.24 25: VDPA 815.30 26: CARL 7.00 27: LOLA 1019.78 false}, session=+254700000000, persister=persister @0xc0004fe600 state:0xc000453500 cache:0xc0004fe2c0 [I] vm:runner.go:63 vm created with state state=state @0xc000453500 moves: 51 idx: 0 flags: 0x0653100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English), renderer= [T] engine:db.go:422 set language on context lang=eng (English) [D] engine:db.go:329 start pre-VM check [I] vm:runner.go:63 vm created with state state=state @0xc000453500 moves: 52 idx: 0 flags: 0x0653100000000000000000000000000000 path: root/main/my_vouchers/select_voucher/_first lang: eng (English), renderer= [T] vm:runner.go:120 new vm run [D] vm:runner.go:152 execute code opcode=3, op=LOAD, code=065f666972737401000007 [D] vm:runner.go:153 state=state @0xc000453500 moves: 52 idx: 0 flags: 0x1053100000000000000000000000000000 path: root/main/my_vouchers/select_voucher/_first lang: eng (English) [D] ussdmenuhandler:menuhandler.go:138 handler has been initialized state=state @0xc000453500 moves: 52 idx: 0 flags: 0x1053100000000000000000000000000000 path: root/main/my_vouchers/select_voucher/_first lang: eng (English), cache=&{0 426 [map[] map[check_account_created: check_account_status: check_blocked_status:] map[check_balance:Balance: 259.31 VIDZO clear_temporary_value: manage_vouchers:] map[reset_account_authorized:] map[get_vouchers:1: FSPTST 7.08 2: MEKO 10000.00 3: FATIN 1.89 4: NEMA 17.41 5: MNAZI 0.01 6: CALIFO 250.71 7: NYUMBU 9.32 8: MASKA 0.30 9: YSP 0.15 10: GRTV 90.35 11: JANET 2.00 12: WADA 15.27 13: NGOSUB 0.00 14: RIBA 0.00 15: SIRI 0.68 16: MISYO 48.41 17: FHE 321.34 18: KHAIRA 0.00 19: TWKL 140.98 20: cUSD 0.50 21: AMUA 98.55 22: SRF 1.36 23: SOHAIL 0.09 24: MOSEYO 8.24 25: VDPA 815.30 26: CARL 7.00 27: LOLA 1019.78] map[]] map[check_account_created:2 check_account_status:0 check_balance:128 check_blocked_status:1 clear_temporary_value:2 create_account:0 get_vouchers:0 manage_vouchers:160 quit:0 reset_account_authorized:16 save_temporary_pin:6 set_language:6 verify_create_pin:8] 1: FSPTST 7.08 2: MEKO 10000.00 3: FATIN 1.89 4: NEMA 17.41 5: MNAZI 0.01 6: CALIFO 250.71 7: NYUMBU 9.32 8: MASKA 0.30 9: YSP 0.15 10: GRTV 90.35 11: JANET 2.00 12: WADA 15.27 13: NGOSUB 0.00 14: RIBA 0.00 15: SIRI 0.68 16: MISYO 48.41 17: FHE 321.34 18: KHAIRA 0.00 19: TWKL 140.98 20: cUSD 0.50 21: AMUA 98.55 22: SRF 1.36 23: SOHAIL 0.09 24: MOSEYO 8.24 25: VDPA 815.30 26: CARL 7.00 27: LOLA 1019.78 false}, x-SessionId=+254700000000 [D] cache:cache.go:70 Cache add key=_first, size=0, limit=0 [T] cache:cache.go:71 Cache add data value= [D] vm:runner.go:152 execute code opcode=7, op=HALT, code= [D] vm:runner.go:153 state=state @0xc000453500 moves: 52 idx: 0 flags: 0x1053100000000000000000000000000000 path: root/main/my_vouchers/select_voucher/_first lang: eng (English) [D] vm:runner.go:440 found HALT, stopping [D] engine:db.go:361 end pre-VM check [T] state:state.go:319 execpath before path=[root main my_vouchers select_voucher _first] [T] state:state.go:326 execpath after path=[root main my_vouchers select_voucher] [D] cache:cache.go:171 Cache free frame=5, key=_first, size=0 [I] engine:db.go:521 new VM execution with input input=3838 [D] engine:db.go:530 start VM run code=0008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [T] vm:runner.go:120 new vm run [D] vm:runner.go:152 execute code opcode=8, op=INCMP, code=013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453500 moves: 53 idx: 0 flags: 0x1053100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [T] vm:runner.go:396 testing sym sym=>, input=3838 [I] vm:runner.go:404 input match input=3838, next=> [D] state:state.go:231 next page location=select_voucher, index=1 [T] resource:db.go:117 getcode sym=select_voucher [T] db:db.go:280 made db lookup key lk=0173656c6563745f766f7563686572, pfx=1 [T] fsdb:fs.go:113 fs get skip missing i=0 [T] fsdb:fs.go:113 fs get skip missing i=1 [T] fsdb:fs.go:116 trying fs get i=2, key=73656c6563745f766f7563686572, path=/var/www/golang/sarafu-vise/services/registration/1select_voucher [T] fsdb:fs.go:116 trying fs get i=3, key=73656c6563745f766f7563686572, path=/var/www/golang/sarafu-vise/services/registration/select_voucher.bin [D] vm:runner.go:428 loaded additional code next=select_voucher, code=00010a6e6f5f766f7563686572011a0100030c6765745f766f756368657273010000050c6765745f766f756368657273000a046261636b0130000a0471756974023939000b046e657874023838000c047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:152 execute code opcode=8, op=INCMP, code=013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a00010a6e6f5f766f7563686572011a0100030c6765745f766f756368657273010000050c6765745f766f756368657273000a046261636b0130000a0471756974023939000b046e657874023838000c047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453500 moves: 54 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [T] vm:runner.go:396 testing sym sym=<, input=3838 [D] vm:runner.go:152 execute code opcode=8, op=INCMP, code=015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a00010a6e6f5f766f7563686572011a0100030c6765745f766f756368657273010000050c6765745f766f756368657273000a046261636b0130000a0471756974023939000b046e657874023838000c047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453500 moves: 54 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [T] vm:runner.go:396 testing sym sym=_, input=3838 [D] vm:runner.go:152 execute code opcode=8, op=INCMP, code=047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a00010a6e6f5f766f7563686572011a0100030c6765745f766f756368657273010000050c6765745f766f756368657273000a046261636b0130000a0471756974023939000b046e657874023838000c047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453500 moves: 54 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [T] vm:runner.go:396 testing sym sym=quit, input=3838 [D] vm:runner.go:152 execute code opcode=3, op=LOAD, code=0c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a00010a6e6f5f766f7563686572011a0100030c6765745f766f756368657273010000050c6765745f766f756368657273000a046261636b0130000a0471756974023939000b046e657874023838000c047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453500 moves: 54 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [D] cache:cache.go:70 Cache add key=view_voucher, size=0, limit=80 [T] cache:cache.go:71 Cache add data value= [D] vm:runner.go:152 execute code opcode=4, op=RELOAD, code=0c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a00010a6e6f5f766f7563686572011a0100030c6765745f766f756368657273010000050c6765745f766f756368657273000a046261636b0130000a0471756974023939000b046e657874023838000c047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453500 moves: 54 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [T] render:page.go:117 mapped key=view_voucher [D] vm:runner.go:152 execute code opcode=1, op=CATCH, code=012e01180100080c766965775f766f7563686572012a00010a6e6f5f766f7563686572011a0100030c6765745f766f756368657273010000050c6765745f766f756368657273000a046261636b0130000a0471756974023939000b046e657874023838000c047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453500 moves: 54 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [D] vm:runner.go:152 execute code opcode=8, op=INCMP, code=0c766965775f766f7563686572012a00010a6e6f5f766f7563686572011a0100030c6765745f766f756368657273010000050c6765745f766f756368657273000a046261636b0130000a0471756974023939000b046e657874023838000c047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453500 moves: 54 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [T] vm:runner.go:396 testing sym sym=view_voucher, input=3838 [D] vm:runner.go:152 execute code opcode=1, op=CATCH, code=0a6e6f5f766f7563686572011a0100030c6765745f766f756368657273010000050c6765745f766f756368657273000a046261636b0130000a0471756974023939000b046e657874023838000c047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453500 moves: 54 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [D] vm:runner.go:152 execute code opcode=3, op=LOAD, code=0c6765745f766f756368657273010000050c6765745f766f756368657273000a046261636b0130000a0471756974023939000b046e657874023838000c047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453500 moves: 54 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [D] vm:runner.go:311 skip already loaded symbol symbol=get_vouchers [D] vm:runner.go:152 execute code opcode=5, op=MAP, code=0c6765745f766f756368657273000a046261636b0130000a0471756974023939000b046e657874023838000c047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453500 moves: 54 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [T] render:page.go:117 mapped key=get_vouchers [D] vm:runner.go:152 execute code opcode=10, op=MOUT, code=046261636b0130000a0471756974023939000b046e657874023838000c047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453500 moves: 54 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [D] vm:runner.go:152 execute code opcode=10, op=MOUT, code=0471756974023939000b046e657874023838000c047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453500 moves: 54 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [D] vm:runner.go:152 execute code opcode=11, op=MNEXT, code=046e657874023838000c047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453500 moves: 54 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [D] vm:runner.go:152 execute code opcode=12, op=MPREV, code=047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453500 moves: 54 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [D] vm:runner.go:152 execute code opcode=7, op=HALT, code=0008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453500 moves: 54 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [D] vm:runner.go:440 found HALT, stopping [D] engine:db.go:537 end VM run code=0008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a, state=state @0xc000453500 moves: 54 idx: 1 flags: 0x1653100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English), vm=vm (0xc0005b80c0) ok [D] state:state.go:346 code changed (set) code=0008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [T] engine:db.go:569 render with state state=state @0xc000453500 moves: 54 idx: 1 flags: 0x1653100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [I] render:page.go:234 found sink sym=select_voucher, sink=get_vouchers [D] render:size.go:87 Added cursor offset=0 [T] db:db.go:275 language using ln=eng (English) [T] db:db.go:280 made db lookup key lk=0473656c6563745f766f7563686572, pfx=4 [T] fsdb:fs.go:116 trying fs get i=0, key=73656c6563745f766f7563686572, path=/var/www/golang/sarafu-vise/services/registration/4select_voucher_eng [T] fsdb:fs.go:116 trying fs get i=1, key=73656c6563745f766f7563686572, path=/var/www/golang/sarafu-vise/services/registration/select_voucher_eng [T] fsdb:fs.go:116 trying fs get i=2, key=73656c6563745f766f7563686572, path=/var/www/golang/sarafu-vise/services/registration/4select_voucher [T] fsdb:fs.go:116 trying fs get i=3, key=73656c6563745f766f7563686572, path=/var/www/golang/sarafu-vise/services/registration/select_voucher [T] render:size.go:100 check values k=view_voucher, v=, idx=0, cursors=[0] [T] render:size.go:100 check values k=get_vouchers, v=, idx=0, cursors=[0] [D] render:page.go:175 render for index=0 [D] render:page.go:391 rendered template bytes=44 [T] db:db.go:275 language using ln=eng (English) [T] db:db.go:280 made db lookup key lk=026261636b5f6d656e75, pfx=2 [T] fsdb:fs.go:116 trying fs get i=0, key=6261636b5f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2back_menu_eng [T] fsdb:fs.go:116 trying fs get i=1, key=6261636b5f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/back_menu_eng [T] fsdb:fs.go:116 trying fs get i=2, key=6261636b5f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2back_menu [T] fsdb:fs.go:116 trying fs get i=3, key=6261636b5f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/back_menu [T] db:db.go:275 language using ln=eng (English) [T] db:db.go:280 made db lookup key lk=02717569745f6d656e75, pfx=2 [T] fsdb:fs.go:116 trying fs get i=0, key=717569745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2quit_menu_eng [T] fsdb:fs.go:116 trying fs get i=1, key=717569745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/quit_menu_eng [T] fsdb:fs.go:116 trying fs get i=2, key=717569745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2quit_menu [T] fsdb:fs.go:116 trying fs get i=3, key=717569745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/quit_menu [D] render:page.go:400 rendered menu bytes=16 [D] render:menu.go:261 applypage m=pagecount: 2 menusink: false next: true prev: false, idx=0 [D] render:menu.go:261 applypage m=pagecount: 2 menusink: false next: false prev: true, idx=1 [D] render:page.go:361 calculated pre-navigation allocation bytes=99, menusizes=[0 7 7 14] [T] render:page.go:267 processing sink idx=0, value=1: FSPTST 7.08, netremaining=90, l=14 [T] render:page.go:267 processing sink idx=1, value=2: MEKO 10000.00, netremaining=90, l=30 [T] render:page.go:267 processing sink idx=2, value=3: FATIN 1.89, netremaining=90, l=44 [T] render:page.go:267 processing sink idx=3, value=4: NEMA 17.41, netremaining=90, l=58 [T] render:page.go:267 processing sink idx=4, value=5: MNAZI 0.01, netremaining=90, l=72 [T] render:page.go:267 processing sink idx=5, value=6: CALIFO 250.71, netremaining=90, l=89 [T] render:page.go:267 processing sink idx=6, value=7: NYUMBU 9.32, netremaining=90, l=104 [D] render:size.go:87 Added cursor offset=91 [T] render:page.go:267 processing sink idx=7, value=8: MASKA 0.30, netremaining=82, l=27 [T] render:page.go:267 processing sink idx=8, value=9: YSP 0.15, netremaining=82, l=39 [T] render:page.go:267 processing sink idx=9, value=10: GRTV 90.35, netremaining=82, l=54 [T] render:page.go:267 processing sink idx=10, value=11: JANET 2.00, netremaining=82, l=69 [T] render:page.go:267 processing sink idx=11, value=12: WADA 15.27, netremaining=82, l=84 [D] render:size.go:87 Added cursor offset=162 [T] render:page.go:267 processing sink idx=12, value=13: NGOSUB 0.00, netremaining=82, l=29 [T] render:page.go:267 processing sink idx=13, value=14: RIBA 0.00, netremaining=82, l=43 [T] render:page.go:267 processing sink idx=14, value=15: SIRI 0.68, netremaining=82, l=57 [T] render:page.go:267 processing sink idx=15, value=16: MISYO 48.41, netremaining=82, l=73 [T] render:page.go:267 processing sink idx=16, value=17: FHE 321.34, netremaining=82, l=88 [D] render:size.go:87 Added cursor offset=237 [T] render:page.go:267 processing sink idx=17, value=18: KHAIRA 0.00, netremaining=82, l=29 [T] render:page.go:267 processing sink idx=18, value=19: TWKL 140.98, netremaining=82, l=45 [T] render:page.go:267 processing sink idx=19, value=20: cUSD 0.50, netremaining=82, l=59 [T] render:page.go:267 processing sink idx=20, value=21: AMUA 98.55, netremaining=82, l=74 [T] render:page.go:267 processing sink idx=21, value=22: SRF 1.36, netremaining=82, l=87 [D] render:size.go:87 Added cursor offset=313 [T] render:page.go:267 processing sink idx=22, value=23: SOHAIL 0.09, netremaining=82, l=27 [T] render:page.go:267 processing sink idx=23, value=24: MOSEYO 8.24, netremaining=82, l=43 [T] render:page.go:267 processing sink idx=24, value=25: VDPA 815.30, netremaining=82, l=59 [T] render:page.go:267 processing sink idx=25, value=26: CARL 7.00, netremaining=82, l=73 [T] render:page.go:267 processing sink idx=26, value=27: LOLA 1019.78, netremaining=82, l=90 [D] render:size.go:87 Added cursor offset=388 [T] render:page.go:377 nosinkvalue idx=0, value=1: FSPTST 7.082: MEKO 10000.003: FATIN 1.894: NEMA 17.415: MNAZI 0.016: CALIFO 250.71 [T] render:page.go:377 nosinkvalue idx=1, value=7: NYUMBU 9.328: MASKA 0.309: YSP 0.1510: GRTV 90.3511: JANET 2.00 [T] render:page.go:377 nosinkvalue idx=2, value=12: WADA 15.2713: NGOSUB 0.0014: RIBA 0.0015: SIRI 0.6816: MISYO 48.41 [T] render:page.go:377 nosinkvalue idx=3, value=17: FHE 321.3418: KHAIRA 0.0019: TWKL 140.9820: cUSD 0.5021: AMUA 98.55 [T] render:page.go:377 nosinkvalue idx=4, value=22: SRF 1.3623: SOHAIL 0.0924: MOSEYO 8.2425: VDPA 815.3026: CARL 7.00 [T] render:page.go:377 nosinkvalue idx=5, value=27: LOLA 1019.78 [T] db:db.go:275 language using ln=eng (English) [T] db:db.go:280 made db lookup key lk=0473656c6563745f766f7563686572, pfx=4 [T] fsdb:fs.go:116 trying fs get i=0, key=73656c6563745f766f7563686572, path=/var/www/golang/sarafu-vise/services/registration/4select_voucher_eng [T] fsdb:fs.go:116 trying fs get i=1, key=73656c6563745f766f7563686572, path=/var/www/golang/sarafu-vise/services/registration/select_voucher_eng [T] fsdb:fs.go:116 trying fs get i=2, key=73656c6563745f766f7563686572, path=/var/www/golang/sarafu-vise/services/registration/4select_voucher [T] fsdb:fs.go:116 trying fs get i=3, key=73656c6563745f766f7563686572, path=/var/www/golang/sarafu-vise/services/registration/select_voucher [T] render:size.go:100 check values k=get_vouchers, v=1: FSPTST 7.082: MEKO 10000.003: FATIN 1.894: NEMA 17.415: MNAZI 0.016: CALIFO 250.71 7: NYUMBU 9.328: MASKA 0.309: YSP 0.1510: GRTV 90.3511: JANET 2.00 12: WADA 15.2713: NGOSUB 0.0014: RIBA 0.0015: SIRI 0.6816: MISYO 48.41 17: FHE 321.3418: KHAIRA 0.0019: TWKL 140.9820: cUSD 0.5021: AMUA 98.55 22: SRF 1.3623: SOHAIL 0.0924: MOSEYO 8.2425: VDPA 815.3026: CARL 7.00 27: LOLA 1019.78, idx=1, cursors=[0 91 162 237 313 388] [T] render:size.go:100 check values k=view_voucher, v=, idx=1, cursors=[0 91 162 237 313 388] [D] render:page.go:175 render for index=1 [D] render:page.go:391 rendered template bytes=114 [D] render:menu.go:261 applypage m=pagecount: 6 menusink: false next: true prev: true, idx=1 [T] db:db.go:275 language using ln=eng (English) [T] db:db.go:280 made db lookup key lk=026261636b5f6d656e75, pfx=2 [T] fsdb:fs.go:116 trying fs get i=0, key=6261636b5f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2back_menu_eng [T] fsdb:fs.go:116 trying fs get i=1, key=6261636b5f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/back_menu_eng [T] fsdb:fs.go:116 trying fs get i=2, key=6261636b5f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2back_menu [T] fsdb:fs.go:116 trying fs get i=3, key=6261636b5f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/back_menu [T] db:db.go:275 language using ln=eng (English) [T] db:db.go:280 made db lookup key lk=02717569745f6d656e75, pfx=2 [T] fsdb:fs.go:116 trying fs get i=0, key=717569745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2quit_menu_eng [T] fsdb:fs.go:116 trying fs get i=1, key=717569745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/quit_menu_eng [T] fsdb:fs.go:116 trying fs get i=2, key=717569745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2quit_menu [T] fsdb:fs.go:116 trying fs get i=3, key=717569745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/quit_menu [T] db:db.go:275 language using ln=eng (English) [T] db:db.go:280 made db lookup key lk=026e6578745f6d656e75, pfx=2 [T] fsdb:fs.go:116 trying fs get i=0, key=6e6578745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2next_menu_eng [T] fsdb:fs.go:116 trying fs get i=1, key=6e6578745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/next_menu_eng [T] fsdb:fs.go:116 trying fs get i=2, key=6e6578745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2next_menu [T] fsdb:fs.go:116 trying fs get i=3, key=6e6578745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/next_menu [T] db:db.go:275 language using ln=eng (English) [T] db:db.go:280 made db lookup key lk=02707265765f6d656e75, pfx=2 [T] fsdb:fs.go:116 trying fs get i=0, key=707265765f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2prev_menu_eng [T] fsdb:fs.go:116 trying fs get i=1, key=707265765f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/prev_menu_eng [T] fsdb:fs.go:116 trying fs get i=2, key=707265765f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2prev_menu [T] fsdb:fs.go:116 trying fs get i=3, key=707265765f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/prev_menu [D] render:page.go:400 rendered menu bytes=34 [I] persist:persist.go:100 saving state and cache self=persister @0xc0004fe600 state:0xc000453500 cache:0xc0004fe2c0, key=+254700000000, state=state @0xc000453500 moves: 54 idx: 1 flags: 0x0653100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [T] persist:persist.go:101 saving bytecode code=0008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [T] db:db.go:280 made db lookup key lk=102b323534373030303030303030, pfx=16 [T] postgresdb:pg.go:98 begin single tx err= [T] postgresdb:pg.go:154 put key=2b323534373030303030303030, val=a2655374617465a764436f646558560008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a6845786563506174688464726f6f74646d61696e6b6d795f766f7563686572736e73656c6563745f766f75636865726742697453697a6518886753697a654964780165466c616773510653100000000000000000000000000000654d6f7665731836684c616e6775616765a264436f646563656e67644e616d6567456e676c697368664d656d6f7279a569436163686553697a65006c436163686555736553697a651901aa65436163686585a0a374636865636b5f626c6f636b65645f7374617475736075636865636b5f6163636f756e745f637265617465646074636865636b5f6163636f756e745f73746174757360a375636c6561725f74656d706f726172795f76616c7565606f6d616e6167655f766f756368657273606d636865636b5f62616c616e63657642616c616e63653a203235392e3331205649445a4f0aa1781872657365745f6163636f756e745f617574686f72697a656460a26c6765745f766f756368657273790194313a2046535054535420372e30380a323a204d454b4f2031303030302e30300a333a20464154494e20312e38390a343a204e454d412031372e34310a353a204d4e415a4920302e30310a363a2043414c49464f203235302e37310a373a204e59554d425520392e33320a383a204d41534b4120302e33300a393a2059535020302e31350a31303a20475254562039302e33350a31313a204a414e455420322e30300a31323a20574144412031352e32370a31333a204e474f53554220302e30300a31343a205249424120302e30300a31353a205349524920302e36380a31363a204d4953594f2034382e34310a31373a20464845203332312e33340a31383a204b484149524120302e30300a31393a2054574b4c203134302e39380a32303a206355534420302e35300a32313a20414d55412039382e35350a32323a2053524620312e33360a32333a20534f4841494c20302e30390a32343a204d4f5345594f20382e32340a32353a2056445041203831352e33300a32363a204341524c20372e30300a32373a204c4f4c4120313031392e37386c766965775f766f7563686572606553697a6573ae6d636865636b5f62616c616e63651880717665726966795f6372656174655f70696e086471756974006f6d616e6167655f766f75636865727318a06c6765745f766f756368657273006c7365745f6c616e67756167650675636865636b5f6163636f756e745f6372656174656402781872657365745f6163636f756e745f617574686f72697a6564106c766965775f766f7563686572185074636865636b5f6163636f756e745f7374617475730072736176655f74656d706f726172795f70696e0675636c6561725f74656d706f726172795f76616c7565026e6372656174655f6163636f756e740074636865636b5f626c6f636b65645f73746174757301694c61737456616c756560 [T] postgresdb:pg.go:118 stop single tx err= [T] persist:persist.go:107 state and cache flushed from persister [T] engine:db.go:389 that's a wrap engine=&{0xc000453500 0xc0004fe2c0 0xc0005b80c0 0xc00011f5e0 0xc0004fe600 {160 +254700000000 root 128 0 false false : true false} 0xa86080 true false true 0} [T] postgresdb:pg.go:128 stop multi tx err= [D] atserver:parse.go:48 Received request: {"body":"phoneNumber=%2B254700000000\u0026text=88\u0026="}=?? [I] visedriver.request:base.go:68 new request data={context.Background.WithValue(net/http context value http-server, *http.Server).WithValue(net/http context value local-addr, 127.0.0.1:7123).WithCancel.WithCancel sessionid '+254700000000', rootpath 'root', flagcount 128, language '' [56 56] 0xc0005a80e0 false} [T] postgresdb:pg.go:98 begin single tx err= [D] engine:db.go:214 ca ca=&{0 0 [map[]] map[check_account_created:2 check_account_status:0 check_balance:128 check_blocked_status:1 clear_temporary_value:2 create_account:0 get_vouchers:0 manage_vouchers:160 quit:0 reset_account_authorized:16 save_temporary_pin:6 set_language:6 verify_create_pin:8 view_voucher:80] false} [T] db:db.go:280 made db lookup key lk=102b323534373030303030303030, pfx=16 [T] postgresdb:pg.go:98 begin single tx err= [T] postgresdb:pg.go:181 get key=2b323534373030303030303030 [T] postgresdb:pg.go:118 stop single tx err= [I] persist:persist.go:126 loaded state and cache self=persister @0xc0004fe600 state:0xc000453580 cache:0xc0004fe2c0, key=+254700000000, state=state @0xc000453580 moves: 54 idx: 1 flags: 0x0653100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [T] persist:persist.go:127 loaded bytecode code=0008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [T] engine:db.go:264 set persister st=state @0xc000453580 moves: 54 idx: 1 flags: 0x0653100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English), cac=&{0 426 [map[] map[check_account_created: check_account_status: check_blocked_status:] map[check_balance:Balance: 259.31 VIDZO clear_temporary_value: manage_vouchers:] map[reset_account_authorized:] map[get_vouchers:1: FSPTST 7.08 2: MEKO 10000.00 3: FATIN 1.89 4: NEMA 17.41 5: MNAZI 0.01 6: CALIFO 250.71 7: NYUMBU 9.32 8: MASKA 0.30 9: YSP 0.15 10: GRTV 90.35 11: JANET 2.00 12: WADA 15.27 13: NGOSUB 0.00 14: RIBA 0.00 15: SIRI 0.68 16: MISYO 48.41 17: FHE 321.34 18: KHAIRA 0.00 19: TWKL 140.98 20: cUSD 0.50 21: AMUA 98.55 22: SRF 1.36 23: SOHAIL 0.09 24: MOSEYO 8.24 25: VDPA 815.30 26: CARL 7.00 27: LOLA 1019.78 view_voucher:]] map[check_account_created:2 check_account_status:0 check_balance:128 check_blocked_status:1 clear_temporary_value:2 create_account:0 get_vouchers:0 manage_vouchers:160 quit:0 reset_account_authorized:16 save_temporary_pin:6 set_language:6 verify_create_pin:8 view_voucher:80] false}, session=+254700000000, persister=persister @0xc0004fe600 state:0xc000453580 cache:0xc0004fe2c0 [I] vm:runner.go:63 vm created with state state=state @0xc000453580 moves: 54 idx: 1 flags: 0x0653100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English), renderer= [T] engine:db.go:422 set language on context lang=eng (English) [D] engine:db.go:329 start pre-VM check [I] vm:runner.go:63 vm created with state state=state @0xc000453580 moves: 55 idx: 0 flags: 0x0653100000000000000000000000000000 path: root/main/my_vouchers/select_voucher/_first lang: eng (English), renderer= [T] vm:runner.go:120 new vm run [D] vm:runner.go:152 execute code opcode=3, op=LOAD, code=065f666972737401000007 [D] vm:runner.go:153 state=state @0xc000453580 moves: 55 idx: 0 flags: 0x1053100000000000000000000000000000 path: root/main/my_vouchers/select_voucher/_first lang: eng (English) [D] ussdmenuhandler:menuhandler.go:138 handler has been initialized state=state @0xc000453580 moves: 55 idx: 0 flags: 0x1053100000000000000000000000000000 path: root/main/my_vouchers/select_voucher/_first lang: eng (English), cache=&{0 426 [map[] map[check_account_created: check_account_status: check_blocked_status:] map[check_balance:Balance: 259.31 VIDZO clear_temporary_value: manage_vouchers:] map[reset_account_authorized:] map[get_vouchers:1: FSPTST 7.08 2: MEKO 10000.00 3: FATIN 1.89 4: NEMA 17.41 5: MNAZI 0.01 6: CALIFO 250.71 7: NYUMBU 9.32 8: MASKA 0.30 9: YSP 0.15 10: GRTV 90.35 11: JANET 2.00 12: WADA 15.27 13: NGOSUB 0.00 14: RIBA 0.00 15: SIRI 0.68 16: MISYO 48.41 17: FHE 321.34 18: KHAIRA 0.00 19: TWKL 140.98 20: cUSD 0.50 21: AMUA 98.55 22: SRF 1.36 23: SOHAIL 0.09 24: MOSEYO 8.24 25: VDPA 815.30 26: CARL 7.00 27: LOLA 1019.78 view_voucher:] map[]] map[check_account_created:2 check_account_status:0 check_balance:128 check_blocked_status:1 clear_temporary_value:2 create_account:0 get_vouchers:0 manage_vouchers:160 quit:0 reset_account_authorized:16 save_temporary_pin:6 set_language:6 verify_create_pin:8 view_voucher:80] false}, x-SessionId=+254700000000 [D] cache:cache.go:70 Cache add key=_first, size=0, limit=0 [T] cache:cache.go:71 Cache add data value= [D] vm:runner.go:152 execute code opcode=7, op=HALT, code= [D] vm:runner.go:153 state=state @0xc000453580 moves: 55 idx: 0 flags: 0x1053100000000000000000000000000000 path: root/main/my_vouchers/select_voucher/_first lang: eng (English) [D] vm:runner.go:440 found HALT, stopping [D] engine:db.go:361 end pre-VM check [T] state:state.go:319 execpath before path=[root main my_vouchers select_voucher _first] [T] state:state.go:326 execpath after path=[root main my_vouchers select_voucher] [D] cache:cache.go:171 Cache free frame=5, key=_first, size=0 [I] engine:db.go:521 new VM execution with input input=3838 [D] engine:db.go:530 start VM run code=0008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [T] vm:runner.go:120 new vm run [D] vm:runner.go:152 execute code opcode=8, op=INCMP, code=013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453580 moves: 56 idx: 0 flags: 0x1053100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [T] vm:runner.go:396 testing sym sym=>, input=3838 [I] vm:runner.go:404 input match input=3838, next=> [D] state:state.go:231 next page location=select_voucher, index=1 [T] resource:db.go:117 getcode sym=select_voucher [T] db:db.go:280 made db lookup key lk=0173656c6563745f766f7563686572, pfx=1 [T] fsdb:fs.go:113 fs get skip missing i=0 [T] fsdb:fs.go:113 fs get skip missing i=1 [T] fsdb:fs.go:116 trying fs get i=2, key=73656c6563745f766f7563686572, path=/var/www/golang/sarafu-vise/services/registration/1select_voucher [T] fsdb:fs.go:116 trying fs get i=3, key=73656c6563745f766f7563686572, path=/var/www/golang/sarafu-vise/services/registration/select_voucher.bin [D] vm:runner.go:428 loaded additional code next=select_voucher, code=00010a6e6f5f766f7563686572011a0100030c6765745f766f756368657273010000050c6765745f766f756368657273000a046261636b0130000a0471756974023939000b046e657874023838000c047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:152 execute code opcode=8, op=INCMP, code=013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a00010a6e6f5f766f7563686572011a0100030c6765745f766f756368657273010000050c6765745f766f756368657273000a046261636b0130000a0471756974023939000b046e657874023838000c047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453580 moves: 57 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [T] vm:runner.go:396 testing sym sym=<, input=3838 [D] vm:runner.go:152 execute code opcode=8, op=INCMP, code=015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a00010a6e6f5f766f7563686572011a0100030c6765745f766f756368657273010000050c6765745f766f756368657273000a046261636b0130000a0471756974023939000b046e657874023838000c047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453580 moves: 57 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [T] vm:runner.go:396 testing sym sym=_, input=3838 [D] vm:runner.go:152 execute code opcode=8, op=INCMP, code=047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a00010a6e6f5f766f7563686572011a0100030c6765745f766f756368657273010000050c6765745f766f756368657273000a046261636b0130000a0471756974023939000b046e657874023838000c047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453580 moves: 57 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [T] vm:runner.go:396 testing sym sym=quit, input=3838 [D] vm:runner.go:152 execute code opcode=3, op=LOAD, code=0c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a00010a6e6f5f766f7563686572011a0100030c6765745f766f756368657273010000050c6765745f766f756368657273000a046261636b0130000a0471756974023939000b046e657874023838000c047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453580 moves: 57 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [D] vm:runner.go:311 skip already loaded symbol symbol=view_voucher [D] vm:runner.go:152 execute code opcode=4, op=RELOAD, code=0c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a00010a6e6f5f766f7563686572011a0100030c6765745f766f756368657273010000050c6765745f766f756368657273000a046261636b0130000a0471756974023939000b046e657874023838000c047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453580 moves: 57 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [T] render:page.go:117 mapped key=view_voucher [D] vm:runner.go:152 execute code opcode=1, op=CATCH, code=012e01180100080c766965775f766f7563686572012a00010a6e6f5f766f7563686572011a0100030c6765745f766f756368657273010000050c6765745f766f756368657273000a046261636b0130000a0471756974023939000b046e657874023838000c047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453580 moves: 57 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [D] vm:runner.go:152 execute code opcode=8, op=INCMP, code=0c766965775f766f7563686572012a00010a6e6f5f766f7563686572011a0100030c6765745f766f756368657273010000050c6765745f766f756368657273000a046261636b0130000a0471756974023939000b046e657874023838000c047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453580 moves: 57 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [T] vm:runner.go:396 testing sym sym=view_voucher, input=3838 [D] vm:runner.go:152 execute code opcode=1, op=CATCH, code=0a6e6f5f766f7563686572011a0100030c6765745f766f756368657273010000050c6765745f766f756368657273000a046261636b0130000a0471756974023939000b046e657874023838000c047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453580 moves: 57 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [D] vm:runner.go:152 execute code opcode=3, op=LOAD, code=0c6765745f766f756368657273010000050c6765745f766f756368657273000a046261636b0130000a0471756974023939000b046e657874023838000c047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453580 moves: 57 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [D] vm:runner.go:311 skip already loaded symbol symbol=get_vouchers [D] vm:runner.go:152 execute code opcode=5, op=MAP, code=0c6765745f766f756368657273000a046261636b0130000a0471756974023939000b046e657874023838000c047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453580 moves: 57 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [T] render:page.go:117 mapped key=get_vouchers [D] vm:runner.go:152 execute code opcode=10, op=MOUT, code=046261636b0130000a0471756974023939000b046e657874023838000c047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453580 moves: 57 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [D] vm:runner.go:152 execute code opcode=10, op=MOUT, code=0471756974023939000b046e657874023838000c047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453580 moves: 57 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [D] vm:runner.go:152 execute code opcode=11, op=MNEXT, code=046e657874023838000c047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453580 moves: 57 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [D] vm:runner.go:152 execute code opcode=12, op=MPREV, code=047072657602393800070008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453580 moves: 57 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [D] vm:runner.go:152 execute code opcode=7, op=HALT, code=0008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [D] vm:runner.go:153 state=state @0xc000453580 moves: 57 idx: 1 flags: 0x1253100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [D] vm:runner.go:440 found HALT, stopping [D] engine:db.go:537 end VM run code=0008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a, state=state @0xc000453580 moves: 57 idx: 1 flags: 0x1653100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English), vm=vm (0xc0005a0240) ok [D] state:state.go:346 code changed (set) code=0008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [T] engine:db.go:569 render with state state=state @0xc000453580 moves: 57 idx: 1 flags: 0x1653100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [I] render:page.go:234 found sink sym=select_voucher, sink=get_vouchers [D] render:size.go:87 Added cursor offset=0 [T] db:db.go:275 language using ln=eng (English) [T] db:db.go:280 made db lookup key lk=0473656c6563745f766f7563686572, pfx=4 [T] fsdb:fs.go:116 trying fs get i=0, key=73656c6563745f766f7563686572, path=/var/www/golang/sarafu-vise/services/registration/4select_voucher_eng [T] fsdb:fs.go:116 trying fs get i=1, key=73656c6563745f766f7563686572, path=/var/www/golang/sarafu-vise/services/registration/select_voucher_eng [T] fsdb:fs.go:116 trying fs get i=2, key=73656c6563745f766f7563686572, path=/var/www/golang/sarafu-vise/services/registration/4select_voucher [T] fsdb:fs.go:116 trying fs get i=3, key=73656c6563745f766f7563686572, path=/var/www/golang/sarafu-vise/services/registration/select_voucher [T] render:size.go:100 check values k=view_voucher, v=, idx=0, cursors=[0] [T] render:size.go:100 check values k=get_vouchers, v=, idx=0, cursors=[0] [D] render:page.go:175 render for index=0 [D] render:page.go:391 rendered template bytes=44 [T] db:db.go:275 language using ln=eng (English) [T] db:db.go:280 made db lookup key lk=026261636b5f6d656e75, pfx=2 [T] fsdb:fs.go:116 trying fs get i=0, key=6261636b5f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2back_menu_eng [T] fsdb:fs.go:116 trying fs get i=1, key=6261636b5f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/back_menu_eng [T] fsdb:fs.go:116 trying fs get i=2, key=6261636b5f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2back_menu [T] fsdb:fs.go:116 trying fs get i=3, key=6261636b5f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/back_menu [T] db:db.go:275 language using ln=eng (English) [T] db:db.go:280 made db lookup key lk=02717569745f6d656e75, pfx=2 [T] fsdb:fs.go:116 trying fs get i=0, key=717569745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2quit_menu_eng [T] fsdb:fs.go:116 trying fs get i=1, key=717569745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/quit_menu_eng [T] fsdb:fs.go:116 trying fs get i=2, key=717569745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2quit_menu [T] fsdb:fs.go:116 trying fs get i=3, key=717569745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/quit_menu [D] render:page.go:400 rendered menu bytes=16 [D] render:menu.go:261 applypage m=pagecount: 2 menusink: false next: true prev: false, idx=0 [D] render:menu.go:261 applypage m=pagecount: 2 menusink: false next: false prev: true, idx=1 [D] render:page.go:361 calculated pre-navigation allocation bytes=99, menusizes=[0 7 7 14] [T] render:page.go:267 processing sink idx=0, value=1: FSPTST 7.08, netremaining=90, l=14 [T] render:page.go:267 processing sink idx=1, value=2: MEKO 10000.00, netremaining=90, l=30 [T] render:page.go:267 processing sink idx=2, value=3: FATIN 1.89, netremaining=90, l=44 [T] render:page.go:267 processing sink idx=3, value=4: NEMA 17.41, netremaining=90, l=58 [T] render:page.go:267 processing sink idx=4, value=5: MNAZI 0.01, netremaining=90, l=72 [T] render:page.go:267 processing sink idx=5, value=6: CALIFO 250.71, netremaining=90, l=89 [T] render:page.go:267 processing sink idx=6, value=7: NYUMBU 9.32, netremaining=90, l=104 [D] render:size.go:87 Added cursor offset=91 [T] render:page.go:267 processing sink idx=7, value=8: MASKA 0.30, netremaining=82, l=27 [T] render:page.go:267 processing sink idx=8, value=9: YSP 0.15, netremaining=82, l=39 [T] render:page.go:267 processing sink idx=9, value=10: GRTV 90.35, netremaining=82, l=54 [T] render:page.go:267 processing sink idx=10, value=11: JANET 2.00, netremaining=82, l=69 [T] render:page.go:267 processing sink idx=11, value=12: WADA 15.27, netremaining=82, l=84 [D] render:size.go:87 Added cursor offset=162 [T] render:page.go:267 processing sink idx=12, value=13: NGOSUB 0.00, netremaining=82, l=29 [T] render:page.go:267 processing sink idx=13, value=14: RIBA 0.00, netremaining=82, l=43 [T] render:page.go:267 processing sink idx=14, value=15: SIRI 0.68, netremaining=82, l=57 [T] render:page.go:267 processing sink idx=15, value=16: MISYO 48.41, netremaining=82, l=73 [T] render:page.go:267 processing sink idx=16, value=17: FHE 321.34, netremaining=82, l=88 [D] render:size.go:87 Added cursor offset=237 [T] render:page.go:267 processing sink idx=17, value=18: KHAIRA 0.00, netremaining=82, l=29 [T] render:page.go:267 processing sink idx=18, value=19: TWKL 140.98, netremaining=82, l=45 [T] render:page.go:267 processing sink idx=19, value=20: cUSD 0.50, netremaining=82, l=59 [T] render:page.go:267 processing sink idx=20, value=21: AMUA 98.55, netremaining=82, l=74 [T] render:page.go:267 processing sink idx=21, value=22: SRF 1.36, netremaining=82, l=87 [D] render:size.go:87 Added cursor offset=313 [T] render:page.go:267 processing sink idx=22, value=23: SOHAIL 0.09, netremaining=82, l=27 [T] render:page.go:267 processing sink idx=23, value=24: MOSEYO 8.24, netremaining=82, l=43 [T] render:page.go:267 processing sink idx=24, value=25: VDPA 815.30, netremaining=82, l=59 [T] render:page.go:267 processing sink idx=25, value=26: CARL 7.00, netremaining=82, l=73 [T] render:page.go:267 processing sink idx=26, value=27: LOLA 1019.78, netremaining=82, l=90 [D] render:size.go:87 Added cursor offset=388 [T] render:page.go:377 nosinkvalue idx=0, value=1: FSPTST 7.082: MEKO 10000.003: FATIN 1.894: NEMA 17.415: MNAZI 0.016: CALIFO 250.71 [T] render:page.go:377 nosinkvalue idx=1, value=7: NYUMBU 9.328: MASKA 0.309: YSP 0.1510: GRTV 90.3511: JANET 2.00 [T] render:page.go:377 nosinkvalue idx=2, value=12: WADA 15.2713: NGOSUB 0.0014: RIBA 0.0015: SIRI 0.6816: MISYO 48.41 [T] render:page.go:377 nosinkvalue idx=3, value=17: FHE 321.3418: KHAIRA 0.0019: TWKL 140.9820: cUSD 0.5021: AMUA 98.55 [T] render:page.go:377 nosinkvalue idx=4, value=22: SRF 1.3623: SOHAIL 0.0924: MOSEYO 8.2425: VDPA 815.3026: CARL 7.00 [T] render:page.go:377 nosinkvalue idx=5, value=27: LOLA 1019.78 [T] db:db.go:275 language using ln=eng (English) [T] db:db.go:280 made db lookup key lk=0473656c6563745f766f7563686572, pfx=4 [T] fsdb:fs.go:116 trying fs get i=0, key=73656c6563745f766f7563686572, path=/var/www/golang/sarafu-vise/services/registration/4select_voucher_eng [T] fsdb:fs.go:116 trying fs get i=1, key=73656c6563745f766f7563686572, path=/var/www/golang/sarafu-vise/services/registration/select_voucher_eng [T] fsdb:fs.go:116 trying fs get i=2, key=73656c6563745f766f7563686572, path=/var/www/golang/sarafu-vise/services/registration/4select_voucher [T] fsdb:fs.go:116 trying fs get i=3, key=73656c6563745f766f7563686572, path=/var/www/golang/sarafu-vise/services/registration/select_voucher [T] render:size.go:100 check values k=view_voucher, v=, idx=1, cursors=[0 91 162 237 313 388] [T] render:size.go:100 check values k=get_vouchers, v=1: FSPTST 7.082: MEKO 10000.003: FATIN 1.894: NEMA 17.415: MNAZI 0.016: CALIFO 250.71 7: NYUMBU 9.328: MASKA 0.309: YSP 0.1510: GRTV 90.3511: JANET 2.00 12: WADA 15.2713: NGOSUB 0.0014: RIBA 0.0015: SIRI 0.6816: MISYO 48.41 17: FHE 321.3418: KHAIRA 0.0019: TWKL 140.9820: cUSD 0.5021: AMUA 98.55 22: SRF 1.3623: SOHAIL 0.0924: MOSEYO 8.2425: VDPA 815.3026: CARL 7.00 27: LOLA 1019.78, idx=1, cursors=[0 91 162 237 313 388] [D] render:page.go:175 render for index=1 [D] render:page.go:391 rendered template bytes=114 [D] render:menu.go:261 applypage m=pagecount: 6 menusink: false next: true prev: true, idx=1 [T] db:db.go:275 language using ln=eng (English) [T] db:db.go:280 made db lookup key lk=026261636b5f6d656e75, pfx=2 [T] fsdb:fs.go:116 trying fs get i=0, key=6261636b5f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2back_menu_eng [T] fsdb:fs.go:116 trying fs get i=1, key=6261636b5f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/back_menu_eng [T] fsdb:fs.go:116 trying fs get i=2, key=6261636b5f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2back_menu [T] fsdb:fs.go:116 trying fs get i=3, key=6261636b5f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/back_menu [T] db:db.go:275 language using ln=eng (English) [T] db:db.go:280 made db lookup key lk=02717569745f6d656e75, pfx=2 [T] fsdb:fs.go:116 trying fs get i=0, key=717569745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2quit_menu_eng [T] fsdb:fs.go:116 trying fs get i=1, key=717569745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/quit_menu_eng [T] fsdb:fs.go:116 trying fs get i=2, key=717569745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2quit_menu [T] fsdb:fs.go:116 trying fs get i=3, key=717569745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/quit_menu [T] db:db.go:275 language using ln=eng (English) [T] db:db.go:280 made db lookup key lk=026e6578745f6d656e75, pfx=2 [T] fsdb:fs.go:116 trying fs get i=0, key=6e6578745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2next_menu_eng [T] fsdb:fs.go:116 trying fs get i=1, key=6e6578745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/next_menu_eng [T] fsdb:fs.go:116 trying fs get i=2, key=6e6578745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2next_menu [T] fsdb:fs.go:116 trying fs get i=3, key=6e6578745f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/next_menu [T] db:db.go:275 language using ln=eng (English) [T] db:db.go:280 made db lookup key lk=02707265765f6d656e75, pfx=2 [T] fsdb:fs.go:116 trying fs get i=0, key=707265765f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2prev_menu_eng [T] fsdb:fs.go:116 trying fs get i=1, key=707265765f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/prev_menu_eng [T] fsdb:fs.go:116 trying fs get i=2, key=707265765f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/2prev_menu [T] fsdb:fs.go:116 trying fs get i=3, key=707265765f6d656e75, path=/var/www/golang/sarafu-vise/services/registration/prev_menu [D] render:page.go:400 rendered menu bytes=34 [I] persist:persist.go:100 saving state and cache self=persister @0xc0004fe600 state:0xc000453580 cache:0xc0004fe2c0, key=+254700000000, state=state @0xc000453580 moves: 57 idx: 1 flags: 0x0653100000000000000000000000000000 path: root/main/my_vouchers/select_voucher lang: eng (English) [T] persist:persist.go:101 saving bytecode code=0008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a [T] db:db.go:280 made db lookup key lk=102b323534373030303030303030, pfx=16 [T] postgresdb:pg.go:98 begin single tx err= [T] postgresdb:pg.go:154 put key=2b323534373030303030303030, val=a2655374617465a764436f646558560008013e0238380008013c0239380008015f01300008047175697402393900030c766965775f766f7563686572015000040c766965775f766f75636865720001012e01180100080c766965775f766f7563686572012a6845786563506174688464726f6f74646d61696e6b6d795f766f7563686572736e73656c6563745f766f75636865726742697453697a6518886753697a654964780165466c616773510653100000000000000000000000000000654d6f7665731839684c616e6775616765a264436f646563656e67644e616d6567456e676c697368664d656d6f7279a569436163686553697a65006c436163686555736553697a651901aa65436163686585a0a374636865636b5f626c6f636b65645f7374617475736075636865636b5f6163636f756e745f637265617465646074636865636b5f6163636f756e745f73746174757360a375636c6561725f74656d706f726172795f76616c7565606f6d616e6167655f766f756368657273606d636865636b5f62616c616e63657642616c616e63653a203235392e3331205649445a4f0aa1781872657365745f6163636f756e745f617574686f72697a656460a26c6765745f766f756368657273790194313a2046535054535420372e30380a323a204d454b4f2031303030302e30300a333a20464154494e20312e38390a343a204e454d412031372e34310a353a204d4e415a4920302e30310a363a2043414c49464f203235302e37310a373a204e59554d425520392e33320a383a204d41534b4120302e33300a393a2059535020302e31350a31303a20475254562039302e33350a31313a204a414e455420322e30300a31323a20574144412031352e32370a31333a204e474f53554220302e30300a31343a205249424120302e30300a31353a205349524920302e36380a31363a204d4953594f2034382e34310a31373a20464845203332312e33340a31383a204b484149524120302e30300a31393a2054574b4c203134302e39380a32303a206355534420302e35300a32313a20414d55412039382e35350a32323a2053524620312e33360a32333a20534f4841494c20302e30390a32343a204d4f5345594f20382e32340a32353a2056445041203831352e33300a32363a204341524c20372e30300a32373a204c4f4c4120313031392e37386c766965775f766f7563686572606553697a6573ae75636c6561725f74656d706f726172795f76616c7565026e6372656174655f6163636f756e740074636865636b5f626c6f636b65645f737461747573016d636865636b5f62616c616e63651880717665726966795f6372656174655f70696e086471756974006f6d616e6167655f766f75636865727318a06c6765745f766f756368657273006c7365745f6c616e67756167650675636865636b5f6163636f756e745f6372656174656402781872657365745f6163636f756e745f617574686f72697a6564106c766965775f766f7563686572185074636865636b5f6163636f756e745f7374617475730072736176655f74656d706f726172795f70696e06694c61737456616c756560 [T] postgresdb:pg.go:118 stop single tx err= [T] persist:persist.go:107 state and cache flushed from persister [T] engine:db.go:389 that's a wrap engine=&{0xc000453580 0xc0004fe2c0 0xc0005a0240 0xc00011f5e0 0xc0004fe600 {160 +254700000000 root 128 0 false false : true false} 0xa86080 true false true 0} [T] postgresdb:pg.go:128 stop multi tx err=